{"level":"warn","ts":"2026-10-17T10:51:52.033277Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T10:51:52.03341Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.69:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.69:2380","--initial-cluster=instance=https://162.253.55.69:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.69:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.69: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-10-17T10:51:52.033516Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T10:51:52.033536Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.69:2380"]} {"level":"info","ts":"2026-10-17T10:51:52.033569Z","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-10-17T10:51:52.034684Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"]} {"level":"info","ts":"2026-10-17T10:51:52.034804Z","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://162.253.55.69:2380"],"listen-peer-urls":["https://162.253.55.69:2380"],"advertise-client-urls":["https://162.253.55.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.69: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-10-17T10:51:52.039647Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.487015ms"} {"level":"info","ts":"2026-10-17T10:51:52.04858Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"905ccde8a677f143","cluster-id":"6fd07fe3af558460"} {"level":"info","ts":"2026-10-17T10:51:52.048691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T10:51:52.048716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became follower at term 0"} {"level":"info","ts":"2026-10-17T10:51:52.048733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 905ccde8a677f143 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T10:51:52.048755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became follower at term 1"} {"level":"info","ts":"2026-10-17T10:51:52.048804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=(10402415638427988291)"} {"level":"warn","ts":"2026-10-17T10:51:52.059012Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T10:51:52.061176Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T10:51:52.062676Z","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-10-17T10:51:52.064885Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"905ccde8a677f143","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T10:51:52.065033Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"905ccde8a677f143","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T10:51:52.06517Z","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-10-17T10:51:52.065244Z","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-10-17T10:51:52.065258Z","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-10-17T10:51:52.067203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=(10402415638427988291)"} {"level":"info","ts":"2026-10-17T10:51:52.067349Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6fd07fe3af558460","local-member-id":"905ccde8a677f143","added-peer-id":"905ccde8a677f143","added-peer-peer-urls":["https://162.253.55.69:2380"]} {"level":"info","ts":"2026-10-17T10:51:52.070455Z","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-10-17T10:51:52.070643Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.69:2380"} {"level":"info","ts":"2026-10-17T10:51:52.070756Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.69:2380"} {"level":"info","ts":"2026-10-17T10:51:52.070844Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"905ccde8a677f143","initial-advertise-peer-urls":["https://162.253.55.69:2380"],"listen-peer-urls":["https://162.253.55.69:2380"],"advertise-client-urls":["https://162.253.55.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T10:51:52.070899Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T10:51:52.249991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T10:51:52.250038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T10:51:52.250077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 received MsgPreVoteResp from 905ccde8a677f143 at term 1"} {"level":"info","ts":"2026-10-17T10:51:52.250096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became candidate at term 2"} {"level":"info","ts":"2026-10-17T10:51:52.250111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 received MsgVoteResp from 905ccde8a677f143 at term 2"} {"level":"info","ts":"2026-10-17T10:51:52.250154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became leader at term 2"} {"level":"info","ts":"2026-10-17T10:51:52.250171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 905ccde8a677f143 elected leader 905ccde8a677f143 at term 2"} {"level":"info","ts":"2026-10-17T10:51:52.251406Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:51:52.252513Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:51:52.25253Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"905ccde8a677f143","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.69:2379]}","request-path":"/0/members/905ccde8a677f143/attributes","cluster-id":"6fd07fe3af558460","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T10:51:52.252707Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:51:52.25287Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T10:51:52.252912Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T10:51:52.253397Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6fd07fe3af558460","local-member-id":"905ccde8a677f143","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:51:52.253509Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:51:52.253575Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:51:52.254847Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.69:2379"} {"level":"info","ts":"2026-10-17T10:51:52.255709Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T10:52:04.152778Z","caller":"traceutil/trace.go:171","msg":"trace[1278454656] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"141.512418ms","start":"2026-10-17T10:52:04.011242Z","end":"2026-10-17T10:52:04.152754Z","steps":["trace[1278454656] 'process raft request' (duration: 141.373666ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:42.718019Z","caller":"traceutil/trace.go:171","msg":"trace[1482138764] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"142.12594ms","start":"2026-10-17T10:52:42.57579Z","end":"2026-10-17T10:52:42.717916Z","steps":["trace[1482138764] 'process raft request' (duration: 141.924097ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:43.651852Z","caller":"traceutil/trace.go:171","msg":"trace[1295582575] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"530.218636ms","start":"2026-10-17T10:52:43.121608Z","end":"2026-10-17T10:52:43.651827Z","steps":["trace[1295582575] 'process raft request' (duration: 528.652816ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:43.652489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:43.121559Z","time spent":"530.366469ms","remote":"127.0.0.1:34650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:52:43.929201Z","caller":"traceutil/trace.go:171","msg":"trace[1333950626] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"803.908428ms","start":"2026-10-17T10:52:43.125236Z","end":"2026-10-17T10:52:43.929144Z","steps":["trace[1333950626] 'process raft request' (duration: 737.154699ms)","trace[1333950626] 'compare' (duration: 66.534335ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:52:43.929326Z","caller":"traceutil/trace.go:171","msg":"trace[31112953] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"186.198356ms","start":"2026-10-17T10:52:43.743111Z","end":"2026-10-17T10:52:43.929309Z","steps":["trace[31112953] 'process raft request' (duration: 185.979411ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:43.929392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:43.125208Z","time spent":"804.088922ms","remote":"127.0.0.1:34744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:52:43.929224Z","caller":"traceutil/trace.go:171","msg":"trace[711784921] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:673; }","duration":"712.890246ms","start":"2026-10-17T10:52:43.216278Z","end":"2026-10-17T10:52:43.929168Z","steps":["trace[711784921] 'read index received' (duration: 433.320553ms)","trace[711784921] 'applied index is now lower than readState.Index' (duration: 279.568083ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:52:43.929671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.385005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-17T10:52:43.929733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.506195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-17T10:52:43.929858Z","caller":"traceutil/trace.go:171","msg":"trace[1377249709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:651; }","duration":"254.674128ms","start":"2026-10-17T10:52:43.675155Z","end":"2026-10-17T10:52:43.92983Z","steps":["trace[1377249709] 'agreement among raft nodes before linearized reading' (duration: 254.369612ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:43.929859Z","caller":"traceutil/trace.go:171","msg":"trace[1471918802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:651; }","duration":"713.569418ms","start":"2026-10-17T10:52:43.216228Z","end":"2026-10-17T10:52:43.929797Z","steps":["trace[1471918802] 'agreement among raft nodes before linearized reading' (duration: 713.045998ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:43.930017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:43.216208Z","time spent":"713.793772ms","remote":"127.0.0.1:34824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-17T10:52:43.92987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.987353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-17T10:52:43.931247Z","caller":"traceutil/trace.go:171","msg":"trace[212228273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:651; }","duration":"249.349928ms","start":"2026-10-17T10:52:43.681854Z","end":"2026-10-17T10:52:43.931204Z","steps":["trace[212228273] 'agreement among raft nodes before linearized reading' (duration: 247.887861ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:58.161857Z","caller":"traceutil/trace.go:171","msg":"trace[421577944] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:843; }","duration":"149.151618ms","start":"2026-10-17T10:52:58.01268Z","end":"2026-10-17T10:52:58.161832Z","steps":["trace[421577944] 'read index received' (duration: 1.373146ms)","trace[421577944] 'applied index is now lower than readState.Index' (duration: 147.777572ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:52:58.161935Z","caller":"traceutil/trace.go:171","msg":"trace[867673938] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"151.968003ms","start":"2026-10-17T10:52:58.009928Z","end":"2026-10-17T10:52:58.161896Z","steps":["trace[867673938] 'process raft request' (duration: 116.733134ms)","trace[867673938] 'compare' (duration: 35.061275ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:52:58.16206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.362543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-10-17T10:52:58.162119Z","caller":"traceutil/trace.go:171","msg":"trace[2121742606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:815; }","duration":"149.471635ms","start":"2026-10-17T10:52:58.012637Z","end":"2026-10-17T10:52:58.162109Z","steps":["trace[2121742606] 'agreement among raft nodes before linearized reading' (duration: 149.293781ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:58.338157Z","caller":"traceutil/trace.go:171","msg":"trace[1873342857] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"171.549873ms","start":"2026-10-17T10:52:58.166554Z","end":"2026-10-17T10:52:58.338103Z","steps":["trace[1873342857] 'process raft request' (duration: 136.58432ms)","trace[1873342857] 'compare' (duration: 34.214058ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:52:58.337923Z","caller":"traceutil/trace.go:171","msg":"trace[2123429472] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:845; }","duration":"138.850833ms","start":"2026-10-17T10:52:58.19903Z","end":"2026-10-17T10:52:58.337881Z","steps":["trace[2123429472] 'read index received' (duration: 104.005292ms)","trace[2123429472] 'applied index is now lower than readState.Index' (duration: 34.767599ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:52:58.341177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.109754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7js64\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-10-17T10:52:58.341292Z","caller":"traceutil/trace.go:171","msg":"trace[1691839553] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7js64; range_end:; response_count:1; response_revision:816; }","duration":"142.268968ms","start":"2026-10-17T10:52:58.198988Z","end":"2026-10-17T10:52:58.341257Z","steps":["trace[1691839553] 'agreement among raft nodes before linearized reading' (duration: 138.976325ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:10.666992Z","caller":"traceutil/trace.go:171","msg":"trace[428539401] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"135.833801ms","start":"2026-10-17T10:54:10.531123Z","end":"2026-10-17T10:54:10.666957Z","steps":["trace[428539401] 'process raft request' (duration: 135.617627ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:10.666931Z","caller":"traceutil/trace.go:171","msg":"trace[669926231] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1929; }","duration":"126.586884ms","start":"2026-10-17T10:54:10.540317Z","end":"2026-10-17T10:54:10.666904Z","steps":["trace[669926231] 'read index received' (duration: 126.424531ms)","trace[669926231] 'applied index is now lower than readState.Index' (duration: 161.103µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:54:10.667303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.962611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3e4f7758-0fed-4bbb-9e0c-1042703911c9\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-17T10:54:10.667403Z","caller":"traceutil/trace.go:171","msg":"trace[1344462761] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3e4f7758-0fed-4bbb-9e0c-1042703911c9; range_end:; response_count:1; response_revision:1858; }","duration":"127.138715ms","start":"2026-10-17T10:54:10.540237Z","end":"2026-10-17T10:54:10.667376Z","steps":["trace[1344462761] 'agreement among raft nodes before linearized reading' (duration: 126.821038ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:19.444334Z","caller":"traceutil/trace.go:171","msg":"trace[1170020758] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"114.955231ms","start":"2026-10-17T10:54:19.329347Z","end":"2026-10-17T10:54:19.444302Z","steps":["trace[1170020758] 'process raft request' (duration: 114.745997ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:55:50.169801Z","caller":"traceutil/trace.go:171","msg":"trace[2116675013] transaction","detail":"{read_only:false; response_revision:2623; number_of_response:1; }","duration":"223.011412ms","start":"2026-10-17T10:55:49.94676Z","end":"2026-10-17T10:55:50.169771Z","steps":["trace[2116675013] 'process raft request' (duration: 221.492233ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:55:50.171964Z","caller":"traceutil/trace.go:171","msg":"trace[1127940788] transaction","detail":"{read_only:false; response_revision:2624; number_of_response:1; }","duration":"202.482032ms","start":"2026-10-17T10:55:49.969453Z","end":"2026-10-17T10:55:50.171936Z","steps":["trace[1127940788] 'process raft request' (duration: 202.32384ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:55:50.172262Z","caller":"traceutil/trace.go:171","msg":"trace[1645477323] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"139.453806ms","start":"2026-10-17T10:55:50.032758Z","end":"2026-10-17T10:55:50.172212Z","steps":["trace[1645477323] 'process raft request' (duration: 139.13782ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:55:50.172317Z","caller":"traceutil/trace.go:171","msg":"trace[1074751939] transaction","detail":"{read_only:false; response_revision:2626; number_of_response:1; }","duration":"129.68361ms","start":"2026-10-17T10:55:50.042614Z","end":"2026-10-17T10:55:50.172298Z","steps":["trace[1074751939] 'process raft request' (duration: 129.512047ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:56:23.513388Z","caller":"traceutil/trace.go:171","msg":"trace[2113519413] transaction","detail":"{read_only:false; response_revision:2828; number_of_response:1; }","duration":"146.764036ms","start":"2026-10-17T10:56:23.366599Z","end":"2026-10-17T10:56:23.513363Z","steps":["trace[2113519413] 'process raft request' (duration: 135.129045ms)","trace[2113519413] 'compare' (duration: 11.525279ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:59:26.423397Z","caller":"traceutil/trace.go:171","msg":"trace[605017489] transaction","detail":"{read_only:false; response_revision:3996; number_of_response:1; }","duration":"184.69829ms","start":"2026-10-17T10:59:26.238675Z","end":"2026-10-17T10:59:26.423373Z","steps":["trace[605017489] 'process raft request' (duration: 184.303073ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:00:55.123503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.437828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:00:55.123633Z","caller":"traceutil/trace.go:171","msg":"trace[1307826108] linearizableReadLoop","detail":"{readStateIndex:5394; appliedIndex:5393; }","duration":"257.376458ms","start":"2026-10-17T11:00:54.866237Z","end":"2026-10-17T11:00:55.123613Z","steps":["trace[1307826108] 'read index received' (duration: 109.554312ms)","trace[1307826108] 'applied index is now lower than readState.Index' (duration: 147.820596ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:00:55.123722Z","caller":"traceutil/trace.go:171","msg":"trace[1383342473] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"259.254053ms","start":"2026-10-17T11:00:54.864399Z","end":"2026-10-17T11:00:55.123653Z","steps":["trace[1383342473] 'process raft request' (duration: 111.406017ms)","trace[1383342473] 'compare' (duration: 147.205243ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:00:55.123838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.73774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T11:00:55.123846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.916474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-17T11:00:55.123863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.275021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T11:00:55.123866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.610262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-17T11:00:55.123904Z","caller":"traceutil/trace.go:171","msg":"trace[542553857] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5198; }","duration":"187.351253ms","start":"2026-10-17T11:00:54.93654Z","end":"2026-10-17T11:00:55.123892Z","steps":["trace[542553857] 'agreement among raft nodes before linearized reading' (duration: 187.275352ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:00:55.123891Z","caller":"traceutil/trace.go:171","msg":"trace[1384994816] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:5198; }","duration":"252.814731ms","start":"2026-10-17T11:00:54.871058Z","end":"2026-10-17T11:00:55.123873Z","steps":["trace[1384994816] 'agreement among raft nodes before linearized reading' (duration: 252.718859ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:00:55.123901Z","caller":"traceutil/trace.go:171","msg":"trace[1278352344] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:5198; }","duration":"115.002915ms","start":"2026-10-17T11:00:55.008884Z","end":"2026-10-17T11:00:55.123887Z","steps":["trace[1278352344] 'agreement among raft nodes before linearized reading' (duration: 114.907143ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:00:55.123907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.354873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de229533-02cb-47e3-a0b1-2e57c8b2a819\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-10-17T11:00:55.123942Z","caller":"traceutil/trace.go:171","msg":"trace[1698627754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5198; }","duration":"257.730134ms","start":"2026-10-17T11:00:54.86619Z","end":"2026-10-17T11:00:55.123921Z","steps":["trace[1698627754] 'agreement among raft nodes before linearized reading' (duration: 257.475659ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:00:55.123963Z","caller":"traceutil/trace.go:171","msg":"trace[203067624] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-de229533-02cb-47e3-a0b1-2e57c8b2a819; range_end:; response_count:1; response_revision:5198; }","duration":"160.438064ms","start":"2026-10-17T11:00:54.963509Z","end":"2026-10-17T11:00:55.123947Z","steps":["trace[203067624] 'agreement among raft nodes before linearized reading' (duration: 160.285491ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:01:10.104791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.029207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:01:10.104876Z","caller":"traceutil/trace.go:171","msg":"trace[1888011658] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5477; }","duration":"169.144939ms","start":"2026-10-17T11:01:09.935714Z","end":"2026-10-17T11:01:10.104859Z","steps":["trace[1888011658] 'range keys from in-memory index tree' (duration: 168.969406ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:11.164854Z","caller":"traceutil/trace.go:171","msg":"trace[1165171919] linearizableReadLoop","detail":"{readStateIndex:5686; appliedIndex:5685; }","duration":"228.43691ms","start":"2026-10-17T11:01:10.936387Z","end":"2026-10-17T11:01:11.164824Z","steps":["trace[1165171919] 'read index received' (duration: 228.223645ms)","trace[1165171919] 'applied index is now lower than readState.Index' (duration: 211.574µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:01:11.164932Z","caller":"traceutil/trace.go:171","msg":"trace[1798244577] transaction","detail":"{read_only:false; response_revision:5480; number_of_response:1; }","duration":"420.897729ms","start":"2026-10-17T11:01:10.743965Z","end":"2026-10-17T11:01:11.164862Z","steps":["trace[1798244577] 'process raft request' (duration: 420.687535ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:01:11.164998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.601243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:01:11.165041Z","caller":"traceutil/trace.go:171","msg":"trace[394711589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5480; }","duration":"228.694504ms","start":"2026-10-17T11:01:10.936334Z","end":"2026-10-17T11:01:11.165029Z","steps":["trace[394711589] 'agreement among raft nodes before linearized reading' (duration: 228.592163ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:01:11.165162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:01:10.743928Z","time spent":"421.111414ms","remote":"127.0.0.1:34744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8334,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:01:18.072579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.890169ms","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-10-17T11:01:18.072664Z","caller":"traceutil/trace.go:171","msg":"trace[1643126855] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5639; }","duration":"174.015761ms","start":"2026-10-17T11:01:17.89863Z","end":"2026-10-17T11:01:18.072646Z","steps":["trace[1643126855] 'range keys from in-memory index tree' (duration: 173.732315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:01:18.07262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.436511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T11:01:18.072847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.935998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-17T11:01:18.072861Z","caller":"traceutil/trace.go:171","msg":"trace[1321759470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5639; }","duration":"136.740307ms","start":"2026-10-17T11:01:17.936105Z","end":"2026-10-17T11:01:18.072845Z","steps":["trace[1321759470] 'range keys from in-memory index tree' (duration: 136.318479ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:18.072915Z","caller":"traceutil/trace.go:171","msg":"trace[1118968786] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5639; }","duration":"148.039691ms","start":"2026-10-17T11:01:17.924853Z","end":"2026-10-17T11:01:18.072892Z","steps":["trace[1118968786] 'range keys from in-memory index tree' (duration: 147.736564ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:01:18.07291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.057593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-10-17T11:01:18.072982Z","caller":"traceutil/trace.go:171","msg":"trace[1537614176] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5639; }","duration":"182.173745ms","start":"2026-10-17T11:01:17.890792Z","end":"2026-10-17T11:01:18.072965Z","steps":["trace[1537614176] 'range keys from in-memory index tree' (duration: 181.857189ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:01:18.335504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.77892ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:01:18.336014Z","caller":"traceutil/trace.go:171","msg":"trace[983535905] transaction","detail":"{read_only:false; response_revision:5641; number_of_response:1; }","duration":"256.262007ms","start":"2026-10-17T11:01:18.079717Z","end":"2026-10-17T11:01:18.335979Z","steps":["trace[983535905] 'process raft request' (duration: 139.928916ms)","trace[983535905] 'compare' (duration: 115.463204ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:01:52.591839Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2991} {"level":"info","ts":"2026-10-17T11:01:52.659306Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2991,"took":"66.299064ms","hash":771413922,"current-db-size-bytes":56950784,"current-db-size":"57 MB","current-db-size-in-use-bytes":32550912,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T11:01:52.659382Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":771413922,"revision":2991,"compact-revision":-1} {"level":"info","ts":"2026-10-17T11:06:52.600049Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5938} {"level":"info","ts":"2026-10-17T11:06:52.688616Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5938,"took":"86.47499ms","hash":1261235939,"current-db-size-bytes":56950784,"current-db-size":"57 MB","current-db-size-in-use-bytes":26230784,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T11:06:52.688686Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1261235939,"revision":5938,"compact-revision":2991} {"level":"info","ts":"2026-10-17T11:07:26.306459Z","caller":"traceutil/trace.go:171","msg":"trace[522520666] transaction","detail":"{read_only:false; response_revision:8473; number_of_response:1; }","duration":"106.698751ms","start":"2026-10-17T11:07:26.199729Z","end":"2026-10-17T11:07:26.306428Z","steps":["trace[522520666] 'process raft request' (duration: 92.691507ms)","trace[522520666] 'compare' (duration: 13.79156ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:07:26.306535Z","caller":"traceutil/trace.go:171","msg":"trace[114534781] transaction","detail":"{read_only:false; response_revision:8474; number_of_response:1; }","duration":"103.133323ms","start":"2026-10-17T11:07:26.203379Z","end":"2026-10-17T11:07:26.306512Z","steps":["trace[114534781] 'process raft request' (duration: 102.982021ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:38.382474Z","caller":"traceutil/trace.go:171","msg":"trace[1773841639] transaction","detail":"{read_only:false; response_revision:8537; number_of_response:1; }","duration":"216.166834ms","start":"2026-10-17T11:07:38.166286Z","end":"2026-10-17T11:07:38.382453Z","steps":["trace[1773841639] 'process raft request' (duration: 215.94927ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:38.537618Z","caller":"traceutil/trace.go:171","msg":"trace[1678519781] transaction","detail":"{read_only:false; response_revision:8538; number_of_response:1; }","duration":"150.865344ms","start":"2026-10-17T11:07:38.386723Z","end":"2026-10-17T11:07:38.537588Z","steps":["trace[1678519781] 'process raft request' (duration: 93.92418ms)","trace[1678519781] 'compare' (duration: 56.819221ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:07:38.555698Z","caller":"traceutil/trace.go:171","msg":"trace[1041570609] transaction","detail":"{read_only:false; response_revision:8539; number_of_response:1; }","duration":"168.490875ms","start":"2026-10-17T11:07:38.387181Z","end":"2026-10-17T11:07:38.555671Z","steps":["trace[1041570609] 'process raft request' (duration: 168.313402ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:39.190254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.915141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:07:39.190356Z","caller":"traceutil/trace.go:171","msg":"trace[161669348] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:8543; }","duration":"189.062804ms","start":"2026-10-17T11:07:39.001269Z","end":"2026-10-17T11:07:39.190332Z","steps":["trace[161669348] 'count revisions from in-memory index tree' (duration: 188.835789ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:39.1905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.984656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:07:39.190572Z","caller":"traceutil/trace.go:171","msg":"trace[1862104617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8543; }","duration":"255.096359ms","start":"2026-10-17T11:07:38.935457Z","end":"2026-10-17T11:07:39.190554Z","steps":["trace[1862104617] 'range keys from in-memory index tree' (duration: 254.832513ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:39.377577Z","caller":"traceutil/trace.go:171","msg":"trace[1095271965] transaction","detail":"{read_only:false; response_revision:8545; number_of_response:1; }","duration":"182.568561ms","start":"2026-10-17T11:07:39.194985Z","end":"2026-10-17T11:07:39.377554Z","steps":["trace[1095271965] 'process raft request' (duration: 166.977667ms)","trace[1095271965] 'compare' (duration: 15.324119ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:08:07.748985Z","caller":"traceutil/trace.go:171","msg":"trace[397013219] linearizableReadLoop","detail":"{readStateIndex:9062; appliedIndex:9061; }","duration":"273.084974ms","start":"2026-10-17T11:08:07.475877Z","end":"2026-10-17T11:08:07.748962Z","steps":["trace[397013219] 'read index received' (duration: 272.835601ms)","trace[397013219] 'applied index is now lower than readState.Index' (duration: 247.833µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:08:07.74922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.320899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12428"} {"level":"info","ts":"2026-10-17T11:08:07.749261Z","caller":"traceutil/trace.go:171","msg":"trace[1034580162] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8751; }","duration":"273.403031ms","start":"2026-10-17T11:08:07.475844Z","end":"2026-10-17T11:08:07.749247Z","steps":["trace[1034580162] 'agreement among raft nodes before linearized reading' (duration: 273.231228ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:07.749325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.084317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-17T11:08:07.749416Z","caller":"traceutil/trace.go:171","msg":"trace[116213426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8751; }","duration":"245.178648ms","start":"2026-10-17T11:08:07.504204Z","end":"2026-10-17T11:08:07.749382Z","steps":["trace[116213426] 'agreement among raft nodes before linearized reading' (duration: 244.943264ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:07.750451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.370992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-17T11:08:07.750533Z","caller":"traceutil/trace.go:171","msg":"trace[1340866847] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8751; }","duration":"168.507295ms","start":"2026-10-17T11:08:07.582009Z","end":"2026-10-17T11:08:07.750516Z","steps":["trace[1340866847] 'agreement among raft nodes before linearized reading' (duration: 167.17692ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:08:07.750985Z","caller":"traceutil/trace.go:171","msg":"trace[995445904] transaction","detail":"{read_only:false; response_revision:8751; number_of_response:1; }","duration":"350.538573ms","start":"2026-10-17T11:08:07.398474Z","end":"2026-10-17T11:08:07.749013Z","steps":["trace[995445904] 'process raft request' (duration: 350.31849ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:07.751256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:08:07.398459Z","time spent":"352.587942ms","remote":"127.0.0.1:34824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:08:15.940282Z","caller":"traceutil/trace.go:171","msg":"trace[1349635193] transaction","detail":"{read_only:false; response_revision:8795; number_of_response:1; }","duration":"117.759439ms","start":"2026-10-17T11:08:15.822478Z","end":"2026-10-17T11:08:15.940237Z","steps":["trace[1349635193] 'process raft request' (duration: 117.411792ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:20.991163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.847916ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:08:20.991488Z","caller":"traceutil/trace.go:171","msg":"trace[1858538724] linearizableReadLoop","detail":"{readStateIndex:9144; appliedIndex:9142; }","duration":"140.422296ms","start":"2026-10-17T11:08:20.85104Z","end":"2026-10-17T11:08:20.991462Z","steps":["trace[1858538724] 'read index received' (duration: 19.143652ms)","trace[1858538724] 'applied index is now lower than readState.Index' (duration: 121.275254ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:08:20.991545Z","caller":"traceutil/trace.go:171","msg":"trace[300595550] transaction","detail":"{read_only:false; response_revision:8831; number_of_response:1; }","duration":"104.518159ms","start":"2026-10-17T11:08:20.886988Z","end":"2026-10-17T11:08:20.991506Z","steps":["trace[300595550] 'process raft request' (duration: 104.349836ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:08:20.991561Z","caller":"traceutil/trace.go:171","msg":"trace[648045523] transaction","detail":"{read_only:false; response_revision:8829; number_of_response:1; }","duration":"190.138132ms","start":"2026-10-17T11:08:20.801346Z","end":"2026-10-17T11:08:20.991484Z","steps":["trace[648045523] 'process raft request' (duration: 68.884079ms)","trace[648045523] 'compare' (duration: 120.730713ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:08:20.991785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.733435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-jdlrj\" ","response":"range_response_count:1 size:4789"} {"level":"info","ts":"2026-10-17T11:08:20.992135Z","caller":"traceutil/trace.go:171","msg":"trace[1969737034] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-jdlrj; range_end:; response_count:1; response_revision:8832; }","duration":"138.097542ms","start":"2026-10-17T11:08:20.85402Z","end":"2026-10-17T11:08:20.992117Z","steps":["trace[1969737034] 'agreement among raft nodes before linearized reading' (duration: 137.604102ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:20.991784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.204333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-brp8k\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-10-17T11:08:20.992233Z","caller":"traceutil/trace.go:171","msg":"trace[1106659365] range","detail":"{range_begin:/registry/pods/openstack/keepalived-brp8k; range_end:; response_count:1; response_revision:8832; }","duration":"173.681232ms","start":"2026-10-17T11:08:20.818527Z","end":"2026-10-17T11:08:20.992208Z","steps":["trace[1106659365] 'agreement among raft nodes before linearized reading' (duration: 173.04834ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:08:20.991844Z","caller":"traceutil/trace.go:171","msg":"trace[1475071161] transaction","detail":"{read_only:false; response_revision:8830; number_of_response:1; }","duration":"190.02697ms","start":"2026-10-17T11:08:20.801412Z","end":"2026-10-17T11:08:20.991439Z","steps":["trace[1475071161] 'process raft request' (duration: 189.860986ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:08:21.371907Z","caller":"traceutil/trace.go:171","msg":"trace[1312309864] transaction","detail":"{read_only:false; response_revision:8835; number_of_response:1; }","duration":"134.468963ms","start":"2026-10-17T11:08:21.237376Z","end":"2026-10-17T11:08:21.371845Z","steps":["trace[1312309864] 'process raft request' (duration: 134.141187ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:08:21.37174Z","caller":"traceutil/trace.go:171","msg":"trace[1219119647] linearizableReadLoop","detail":"{readStateIndex:9149; appliedIndex:9148; }","duration":"124.872092ms","start":"2026-10-17T11:08:21.246849Z","end":"2026-10-17T11:08:21.371721Z","steps":["trace[1219119647] 'read index received' (duration: 124.583667ms)","trace[1219119647] 'applied index is now lower than readState.Index' (duration: 287.585µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:08:21.372213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.26925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:08:21.372349Z","caller":"traceutil/trace.go:171","msg":"trace[595160269] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:8835; }","duration":"125.518894ms","start":"2026-10-17T11:08:21.246799Z","end":"2026-10-17T11:08:21.372318Z","steps":["trace[595160269] 'agreement among raft nodes before linearized reading' (duration: 125.158938ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:21.462135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.583997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/rook-ceph-cluster\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:08:21.462213Z","caller":"traceutil/trace.go:171","msg":"trace[1966441178] range","detail":"{range_begin:/registry/ingress/openstack/rook-ceph-cluster; range_end:; response_count:0; response_revision:8836; }","duration":"176.728819ms","start":"2026-10-17T11:08:21.285466Z","end":"2026-10-17T11:08:21.462194Z","steps":["trace[1966441178] 'agreement among raft nodes before linearized reading' (duration: 176.582796ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:08:21.462144Z","caller":"traceutil/trace.go:171","msg":"trace[454487900] transaction","detail":"{read_only:false; response_revision:8836; number_of_response:1; }","duration":"144.101104ms","start":"2026-10-17T11:08:21.318002Z","end":"2026-10-17T11:08:21.462103Z","steps":["trace[454487900] 'process raft request' (duration: 143.88776ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:08:28.95376Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000241c.wal"} {"level":"info","ts":"2026-10-17T11:09:46.335688Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"905ccde8a677f143","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:09:46.342356Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T11:09:46.342556Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T11:11:52.606138Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8120} {"level":"info","ts":"2026-10-17T11:11:52.677982Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8120,"took":"69.674339ms","hash":3662985786,"current-db-size-bytes":56950784,"current-db-size":"57 MB","current-db-size-in-use-bytes":29020160,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-17T11:11:52.678051Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3662985786,"revision":8120,"compact-revision":5938} {"level":"info","ts":"2026-10-17T11:16:52.613848Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10561} {"level":"info","ts":"2026-10-17T11:16:52.700697Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10561,"took":"83.979339ms","hash":3863568359,"current-db-size-bytes":56950784,"current-db-size":"57 MB","current-db-size-in-use-bytes":27607040,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T11:16:52.700772Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3863568359,"revision":10561,"compact-revision":8120} {"level":"info","ts":"2026-10-17T11:19:40.789867Z","caller":"traceutil/trace.go:171","msg":"trace[90923643] linearizableReadLoop","detail":"{readStateIndex:14496; appliedIndex:14495; }","duration":"126.73624ms","start":"2026-10-17T11:19:40.663108Z","end":"2026-10-17T11:19:40.789844Z","steps":["trace[90923643] 'read index received' (duration: 126.554687ms)","trace[90923643] 'applied index is now lower than readState.Index' (duration: 180.493µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:19:40.789963Z","caller":"traceutil/trace.go:171","msg":"trace[755542853] transaction","detail":"{read_only:false; response_revision:14013; number_of_response:1; }","duration":"131.51451ms","start":"2026-10-17T11:19:40.658414Z","end":"2026-10-17T11:19:40.789928Z","steps":["trace[755542853] 'process raft request' (duration: 131.269095ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:19:40.790127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.000085ms","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-10-17T11:19:40.79017Z","caller":"traceutil/trace.go:171","msg":"trace[676772514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14013; }","duration":"127.085647ms","start":"2026-10-17T11:19:40.663073Z","end":"2026-10-17T11:19:40.790158Z","steps":["trace[676772514] 'agreement among raft nodes before linearized reading' (duration: 126.930894ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:19:40.790828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.021354ms","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-10-17T11:19:40.790963Z","caller":"traceutil/trace.go:171","msg":"trace[949456932] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14013; }","duration":"119.205546ms","start":"2026-10-17T11:19:40.67173Z","end":"2026-10-17T11:19:40.790935Z","steps":["trace[949456932] 'agreement among raft nodes before linearized reading' (duration: 118.33106ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:19:49.740026Z","caller":"traceutil/trace.go:171","msg":"trace[2147440464] transaction","detail":"{read_only:false; response_revision:14061; number_of_response:1; }","duration":"143.12926ms","start":"2026-10-17T11:19:49.596865Z","end":"2026-10-17T11:19:49.739994Z","steps":["trace[2147440464] 'process raft request' (duration: 121.945509ms)","trace[2147440464] 'compare' (duration: 20.942597ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:19:49.740213Z","caller":"traceutil/trace.go:171","msg":"trace[1785438258] transaction","detail":"{read_only:false; response_revision:14062; number_of_response:1; }","duration":"115.190541ms","start":"2026-10-17T11:19:49.624999Z","end":"2026-10-17T11:19:49.740189Z","steps":["trace[1785438258] 'process raft request' (duration: 114.945936ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:19:58.141986Z","caller":"traceutil/trace.go:171","msg":"trace[236672131] transaction","detail":"{read_only:false; response_revision:14122; number_of_response:1; }","duration":"157.35239ms","start":"2026-10-17T11:19:57.984601Z","end":"2026-10-17T11:19:58.141953Z","steps":["trace[236672131] 'process raft request' (duration: 157.130596ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:21:16.032406Z","caller":"traceutil/trace.go:171","msg":"trace[1136567664] linearizableReadLoop","detail":"{readStateIndex:15596; appliedIndex:15595; }","duration":"100.745983ms","start":"2026-10-17T11:21:15.931638Z","end":"2026-10-17T11:21:16.032384Z","steps":["trace[1136567664] 'read index received' (duration: 100.501138ms)","trace[1136567664] 'applied index is now lower than readState.Index' (duration: 243.945µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:21:16.032523Z","caller":"traceutil/trace.go:171","msg":"trace[266258828] transaction","detail":"{read_only:false; response_revision:15079; number_of_response:1; }","duration":"119.525488ms","start":"2026-10-17T11:21:15.912966Z","end":"2026-10-17T11:21:16.032491Z","steps":["trace[266258828] 'process raft request' (duration: 119.268713ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:21:16.032751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.091809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:21:16.032829Z","caller":"traceutil/trace.go:171","msg":"trace[1855942275] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15079; }","duration":"101.223592ms","start":"2026-10-17T11:21:15.931587Z","end":"2026-10-17T11:21:16.032811Z","steps":["trace[1855942275] 'agreement among raft nodes before linearized reading' (duration: 100.921456ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:21:44.294253Z","caller":"traceutil/trace.go:171","msg":"trace[530270517] transaction","detail":"{read_only:false; response_revision:15227; number_of_response:1; }","duration":"145.216513ms","start":"2026-10-17T11:21:44.14901Z","end":"2026-10-17T11:21:44.294226Z","steps":["trace[530270517] 'process raft request' (duration: 145.05186ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:21:44.295688Z","caller":"traceutil/trace.go:171","msg":"trace[2055291130] linearizableReadLoop","detail":"{readStateIndex:15751; appliedIndex:15749; }","duration":"114.006953ms","start":"2026-10-17T11:21:44.181662Z","end":"2026-10-17T11:21:44.295669Z","steps":["trace[2055291130] 'read index received' (duration: 112.336002ms)","trace[2055291130] 'applied index is now lower than readState.Index' (duration: 1.669921ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:21:44.295958Z","caller":"traceutil/trace.go:171","msg":"trace[779908584] transaction","detail":"{read_only:false; response_revision:15228; number_of_response:1; }","duration":"135.432308ms","start":"2026-10-17T11:21:44.160517Z","end":"2026-10-17T11:21:44.295949Z","steps":["trace[779908584] 'process raft request' (duration: 135.03877ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:21:44.296188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.498863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-17T11:21:44.296217Z","caller":"traceutil/trace.go:171","msg":"trace[883819424] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15228; }","duration":"114.594204ms","start":"2026-10-17T11:21:44.181614Z","end":"2026-10-17T11:21:44.296208Z","steps":["trace[883819424] 'agreement among raft nodes before linearized reading' (duration: 114.472362ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:21:44.296336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.056947ms","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-10-17T11:21:44.296363Z","caller":"traceutil/trace.go:171","msg":"trace[1930208531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15228; }","duration":"103.114227ms","start":"2026-10-17T11:21:44.193244Z","end":"2026-10-17T11:21:44.296358Z","steps":["trace[1930208531] 'agreement among raft nodes before linearized reading' (duration: 103.054646ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:21:44.296675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.287501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-17T11:21:44.2967Z","caller":"traceutil/trace.go:171","msg":"trace[266426698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15228; }","duration":"103.329502ms","start":"2026-10-17T11:21:44.193365Z","end":"2026-10-17T11:21:44.296694Z","steps":["trace[266426698] 'agreement among raft nodes before linearized reading' (duration: 103.270511ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:21:52.620632Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12820} {"level":"info","ts":"2026-10-17T11:21:52.716142Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12820,"took":"90.640793ms","hash":3862400616,"current-db-size-bytes":56950784,"current-db-size":"57 MB","current-db-size-in-use-bytes":30437376,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:21:52.716235Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3862400616,"revision":12820,"compact-revision":10561} {"level":"info","ts":"2026-10-17T11:26:52.643449Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15275} {"level":"info","ts":"2026-10-17T11:26:52.750159Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15275,"took":"103.312915ms","hash":2929545365,"current-db-size-bytes":56950784,"current-db-size":"57 MB","current-db-size-in-use-bytes":31805440,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T11:26:52.750241Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2929545365,"revision":15275,"compact-revision":12820} {"level":"info","ts":"2026-10-17T11:27:42.030865Z","caller":"traceutil/trace.go:171","msg":"trace[1259899469] transaction","detail":"{read_only:false; response_revision:17873; number_of_response:1; }","duration":"138.740267ms","start":"2026-10-17T11:27:41.892086Z","end":"2026-10-17T11:27:42.030826Z","steps":["trace[1259899469] 'process raft request' (duration: 101.173475ms)","trace[1259899469] 'compare' (duration: 36.93568ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:27:42.444978Z","caller":"traceutil/trace.go:171","msg":"trace[837220417] linearizableReadLoop","detail":"{readStateIndex:18489; appliedIndex:18488; }","duration":"199.302542ms","start":"2026-10-17T11:27:42.245645Z","end":"2026-10-17T11:27:42.444947Z","steps":["trace[837220417] 'read index received' (duration: 199.079558ms)","trace[837220417] 'applied index is now lower than readState.Index' (duration: 221.974µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:27:42.445099Z","caller":"traceutil/trace.go:171","msg":"trace[1754915311] transaction","detail":"{read_only:false; response_revision:17876; number_of_response:1; }","duration":"234.873646ms","start":"2026-10-17T11:27:42.210213Z","end":"2026-10-17T11:27:42.445087Z","steps":["trace[1754915311] 'process raft request' (duration: 234.57155ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:27:42.445311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.433196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-ntc2l\" ","response":"range_response_count:1 size:22129"} {"level":"info","ts":"2026-10-17T11:27:42.445384Z","caller":"traceutil/trace.go:171","msg":"trace[444342395] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-ntc2l; range_end:; response_count:1; response_revision:17876; }","duration":"198.537719ms","start":"2026-10-17T11:27:42.246828Z","end":"2026-10-17T11:27:42.445366Z","steps":["trace[444342395] 'agreement among raft nodes before linearized reading' (duration: 198.333685ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:27:42.445465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.835263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-17T11:27:42.445506Z","caller":"traceutil/trace.go:171","msg":"trace[1986850392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17876; }","duration":"199.905404ms","start":"2026-10-17T11:27:42.24559Z","end":"2026-10-17T11:27:42.445496Z","steps":["trace[1986850392] 'agreement among raft nodes before linearized reading' (duration: 199.799402ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:27:50.682094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.908297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:95 size:958700"} {"level":"info","ts":"2026-10-17T11:27:50.682181Z","caller":"traceutil/trace.go:171","msg":"trace[1555446536] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:95; response_revision:17989; }","duration":"103.02073ms","start":"2026-10-17T11:27:50.579142Z","end":"2026-10-17T11:27:50.682162Z","steps":["trace[1555446536] 'range keys from in-memory index tree' (duration: 102.084183ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:30:28.262795Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"905ccde8a677f143","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:30:28.26873Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-17T11:30:28.268829Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-17T11:31:52.648956Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17541} {"level":"info","ts":"2026-10-17T11:31:52.746392Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17541,"took":"93.668473ms","hash":3378673606,"current-db-size-bytes":56950784,"current-db-size":"57 MB","current-db-size-in-use-bytes":34631680,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-17T11:31:52.746464Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3378673606,"revision":17541,"compact-revision":15275} {"level":"info","ts":"2026-10-17T11:33:06.047271Z","caller":"traceutil/trace.go:171","msg":"trace[1941285063] linearizableReadLoop","detail":"{readStateIndex:21131; appliedIndex:21130; }","duration":"110.233336ms","start":"2026-10-17T11:33:05.937013Z","end":"2026-10-17T11:33:06.047247Z","steps":["trace[1941285063] 'read index received' (duration: 110.035082ms)","trace[1941285063] 'applied index is now lower than readState.Index' (duration: 197.454µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:06.047314Z","caller":"traceutil/trace.go:171","msg":"trace[969308983] transaction","detail":"{read_only:false; response_revision:20437; number_of_response:1; }","duration":"201.671657ms","start":"2026-10-17T11:33:05.845619Z","end":"2026-10-17T11:33:06.04729Z","steps":["trace[969308983] 'process raft request' (duration: 201.430682ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:06.047491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.458921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:33:06.047573Z","caller":"traceutil/trace.go:171","msg":"trace[1103572242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20437; }","duration":"110.584782ms","start":"2026-10-17T11:33:05.93697Z","end":"2026-10-17T11:33:06.047555Z","steps":["trace[1103572242] 'agreement among raft nodes before linearized reading' (duration: 110.419979ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:06.27286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.501279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.69\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-10-17T11:33:06.27295Z","caller":"traceutil/trace.go:171","msg":"trace[1325291440] range","detail":"{range_begin:/registry/masterleases/162.253.55.69; range_end:; response_count:1; response_revision:20437; }","duration":"113.631461ms","start":"2026-10-17T11:33:06.159301Z","end":"2026-10-17T11:33:06.272932Z","steps":["trace[1325291440] 'range keys from in-memory index tree' (duration: 113.336286ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:06.272999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.308385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-17T11:33:06.273086Z","caller":"traceutil/trace.go:171","msg":"trace[1027567214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20437; }","duration":"131.450728ms","start":"2026-10-17T11:33:06.141615Z","end":"2026-10-17T11:33:06.273066Z","steps":["trace[1027567214] 'range keys from in-memory index tree' (duration: 131.087661ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:06.398384Z","caller":"traceutil/trace.go:171","msg":"trace[657301635] transaction","detail":"{read_only:false; response_revision:20438; number_of_response:1; }","duration":"121.204964ms","start":"2026-10-17T11:33:06.277157Z","end":"2026-10-17T11:33:06.398362Z","steps":["trace[657301635] 'process raft request' (duration: 120.137884ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:06.398428Z","caller":"traceutil/trace.go:171","msg":"trace[1476395262] transaction","detail":"{read_only:false; response_revision:20439; number_of_response:1; }","duration":"121.237435ms","start":"2026-10-17T11:33:06.277163Z","end":"2026-10-17T11:33:06.3984Z","steps":["trace[1476395262] 'process raft request' (duration: 121.090882ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:22.264518Z","caller":"traceutil/trace.go:171","msg":"trace[1368573203] transaction","detail":"{read_only:false; response_revision:20519; number_of_response:1; }","duration":"139.737744ms","start":"2026-10-17T11:33:22.124745Z","end":"2026-10-17T11:33:22.264483Z","steps":["trace[1368573203] 'process raft request' (duration: 139.502911ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:22.537607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.615747ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T11:33:22.537705Z","caller":"traceutil/trace.go:171","msg":"trace[1790810699] linearizableReadLoop","detail":"{readStateIndex:21219; appliedIndex:21218; }","duration":"266.261299ms","start":"2026-10-17T11:33:22.271427Z","end":"2026-10-17T11:33:22.537689Z","steps":["trace[1790810699] 'read index received' (duration: 139.469309ms)","trace[1790810699] 'applied index is now lower than readState.Index' (duration: 126.79103ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:22.537721Z","caller":"traceutil/trace.go:171","msg":"trace[991752093] transaction","detail":"{read_only:false; response_revision:20520; number_of_response:1; }","duration":"268.657355ms","start":"2026-10-17T11:33:22.269041Z","end":"2026-10-17T11:33:22.537699Z","steps":["trace[991752093] 'process raft request' (duration: 141.885305ms)","trace[991752093] 'compare' (duration: 126.465504ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:33:22.537815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.380262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:33:22.537878Z","caller":"traceutil/trace.go:171","msg":"trace[1924471909] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:20520; }","duration":"266.445583ms","start":"2026-10-17T11:33:22.271396Z","end":"2026-10-17T11:33:22.537842Z","steps":["trace[1924471909] 'agreement among raft nodes before linearized reading' (duration: 266.376652ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:22.744714Z","caller":"traceutil/trace.go:171","msg":"trace[133987646] transaction","detail":"{read_only:false; response_revision:20522; number_of_response:1; }","duration":"201.691178ms","start":"2026-10-17T11:33:22.542995Z","end":"2026-10-17T11:33:22.744686Z","steps":["trace[133987646] 'process raft request' (duration: 189.329064ms)","trace[133987646] 'compare' (duration: 12.262082ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:22.966197Z","caller":"traceutil/trace.go:171","msg":"trace[1914584571] transaction","detail":"{read_only:false; response_revision:20523; number_of_response:1; }","duration":"128.40372ms","start":"2026-10-17T11:33:22.837768Z","end":"2026-10-17T11:33:22.966172Z","steps":["trace[1914584571] 'process raft request' (duration: 54.890388ms)","trace[1914584571] 'compare' (duration: 73.332289ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:22.966524Z","caller":"traceutil/trace.go:171","msg":"trace[861042042] transaction","detail":"{read_only:false; response_revision:20524; number_of_response:1; }","duration":"117.016634ms","start":"2026-10-17T11:33:22.849481Z","end":"2026-10-17T11:33:22.966498Z","steps":["trace[861042042] 'process raft request' (duration: 116.644787ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:23.371684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.591356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12429"} {"level":"info","ts":"2026-10-17T11:33:23.371781Z","caller":"traceutil/trace.go:171","msg":"trace[553136406] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20524; }","duration":"201.733458ms","start":"2026-10-17T11:33:23.170023Z","end":"2026-10-17T11:33:23.371757Z","steps":["trace[553136406] 'range keys from in-memory index tree' (duration: 201.414601ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:23.371775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.073924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-17T11:33:23.371845Z","caller":"traceutil/trace.go:171","msg":"trace[519821670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20524; }","duration":"137.189937ms","start":"2026-10-17T11:33:23.234638Z","end":"2026-10-17T11:33:23.371828Z","steps":["trace[519821670] 'range keys from in-memory index tree' (duration: 136.80828ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:23.371904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.862187ms","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-10-17T11:33:23.371987Z","caller":"traceutil/trace.go:171","msg":"trace[1023327319] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20524; }","duration":"112.976059ms","start":"2026-10-17T11:33:23.258993Z","end":"2026-10-17T11:33:23.371969Z","steps":["trace[1023327319] 'range keys from in-memory index tree' (duration: 112.720024ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:36:52.656491Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19998} {"level":"info","ts":"2026-10-17T11:36:52.789423Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19998,"took":"124.624153ms","hash":4192092033,"current-db-size-bytes":56950784,"current-db-size":"57 MB","current-db-size-in-use-bytes":30334976,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:36:52.789495Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4192092033,"revision":19998,"compact-revision":17541} {"level":"warn","ts":"2026-10-17T11:37:15.845381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.370079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:37:15.845476Z","caller":"traceutil/trace.go:171","msg":"trace[1621033382] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:22957; }","duration":"230.484151ms","start":"2026-10-17T11:37:15.614972Z","end":"2026-10-17T11:37:15.845456Z","steps":["trace[1621033382] 'count revisions from in-memory index tree' (duration: 230.277826ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:37:15.846549Z","caller":"traceutil/trace.go:171","msg":"trace[726932107] transaction","detail":"{read_only:false; response_revision:22958; number_of_response:1; }","duration":"148.026974ms","start":"2026-10-17T11:37:15.698492Z","end":"2026-10-17T11:37:15.846519Z","steps":["trace[726932107] 'process raft request' (duration: 139.710887ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:09.429626Z","caller":"traceutil/trace.go:171","msg":"trace[1625816274] linearizableReadLoop","detail":"{readStateIndex:25511; appliedIndex:25510; }","duration":"179.942305ms","start":"2026-10-17T11:40:09.249658Z","end":"2026-10-17T11:40:09.4296Z","steps":["trace[1625816274] 'read index received' (duration: 164.443103ms)","trace[1625816274] 'applied index is now lower than readState.Index' (duration: 15.498272ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:09.429738Z","caller":"traceutil/trace.go:171","msg":"trace[1574912617] transaction","detail":"{read_only:false; response_revision:24698; number_of_response:1; }","duration":"198.949216ms","start":"2026-10-17T11:40:09.230777Z","end":"2026-10-17T11:40:09.429726Z","steps":["trace[1574912617] 'process raft request' (duration: 183.324321ms)","trace[1574912617] 'compare' (duration: 15.37092ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:40:09.429939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.274432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:1 size:7267"} {"level":"info","ts":"2026-10-17T11:40:09.43Z","caller":"traceutil/trace.go:171","msg":"trace[444924971] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:1; response_revision:24698; }","duration":"180.355783ms","start":"2026-10-17T11:40:09.24961Z","end":"2026-10-17T11:40:09.429966Z","steps":["trace[444924971] 'agreement among raft nodes before linearized reading' (duration: 180.224681ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:09.430248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.277443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T11:40:09.430337Z","caller":"traceutil/trace.go:171","msg":"trace[1143330107] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:24698; }","duration":"126.408036ms","start":"2026-10-17T11:40:09.303906Z","end":"2026-10-17T11:40:09.430314Z","steps":["trace[1143330107] 'agreement among raft nodes before linearized reading' (duration: 126.175681ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:42.00465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.863157ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-17T11:40:42.005049Z","caller":"traceutil/trace.go:171","msg":"trace[1232491188] linearizableReadLoop","detail":"{readStateIndex:25838; appliedIndex:25837; }","duration":"297.570086ms","start":"2026-10-17T11:40:41.707456Z","end":"2026-10-17T11:40:42.005026Z","steps":["trace[1232491188] 'read index received' (duration: 110.269031ms)","trace[1232491188] 'applied index is now lower than readState.Index' (duration: 187.298485ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:42.005058Z","caller":"traceutil/trace.go:171","msg":"trace[1103334971] transaction","detail":"{read_only:false; response_revision:25016; number_of_response:1; }","duration":"164.673008ms","start":"2026-10-17T11:40:41.840369Z","end":"2026-10-17T11:40:42.005042Z","steps":["trace[1103334971] 'process raft request' (duration: 164.503815ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:42.005239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.77678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:40:42.005277Z","caller":"traceutil/trace.go:171","msg":"trace[905048929] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:25016; }","duration":"297.858942ms","start":"2026-10-17T11:40:41.707406Z","end":"2026-10-17T11:40:42.005265Z","steps":["trace[905048929] 'agreement among raft nodes before linearized reading' (duration: 297.76115ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:42.005624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.336725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-17T11:40:42.005661Z","caller":"traceutil/trace.go:171","msg":"trace[781037531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25016; }","duration":"214.413587ms","start":"2026-10-17T11:40:41.791237Z","end":"2026-10-17T11:40:42.005651Z","steps":["trace[781037531] 'agreement among raft nodes before linearized reading' (duration: 214.287805ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:42.005644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.780203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-17T11:40:42.005783Z","caller":"traceutil/trace.go:171","msg":"trace[238543156] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25016; }","duration":"118.937055ms","start":"2026-10-17T11:40:41.88683Z","end":"2026-10-17T11:40:42.005767Z","steps":["trace[238543156] 'agreement among raft nodes before linearized reading' (duration: 118.728011ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:42.005763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.645354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-17T11:40:42.006066Z","caller":"traceutil/trace.go:171","msg":"trace[1322107358] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25016; }","duration":"123.940389ms","start":"2026-10-17T11:40:41.882031Z","end":"2026-10-17T11:40:42.005972Z","steps":["trace[1322107358] 'agreement among raft nodes before linearized reading' (duration: 123.540891ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:42.137292Z","caller":"traceutil/trace.go:171","msg":"trace[729779385] transaction","detail":"{read_only:false; response_revision:25017; number_of_response:1; }","duration":"118.993345ms","start":"2026-10-17T11:40:42.018169Z","end":"2026-10-17T11:40:42.137163Z","steps":["trace[729779385] 'process raft request' (duration: 118.449215ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:42.138097Z","caller":"traceutil/trace.go:171","msg":"trace[408410278] transaction","detail":"{read_only:false; response_revision:25018; number_of_response:1; }","duration":"119.885163ms","start":"2026-10-17T11:40:42.018176Z","end":"2026-10-17T11:40:42.138061Z","steps":["trace[408410278] 'process raft request' (duration: 119.621918ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:42.138151Z","caller":"traceutil/trace.go:171","msg":"trace[1600118912] transaction","detail":"{read_only:false; response_revision:25019; number_of_response:1; }","duration":"119.918574ms","start":"2026-10-17T11:40:42.018195Z","end":"2026-10-17T11:40:42.138113Z","steps":["trace[1600118912] 'process raft request' (duration: 119.74256ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:41:32.416265Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000066d5.wal"} {"level":"info","ts":"2026-10-17T11:41:40.563294Z","caller":"traceutil/trace.go:171","msg":"trace[1203265980] transaction","detail":"{read_only:false; response_revision:25547; number_of_response:1; }","duration":"120.663608ms","start":"2026-10-17T11:41:40.442572Z","end":"2026-10-17T11:41:40.563236Z","steps":["trace[1203265980] 'process raft request' (duration: 120.518235ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:41:40.857454Z","caller":"traceutil/trace.go:171","msg":"trace[308873485] transaction","detail":"{read_only:false; response_revision:25548; number_of_response:1; }","duration":"413.818991ms","start":"2026-10-17T11:41:40.443607Z","end":"2026-10-17T11:41:40.857426Z","steps":["trace[308873485] 'process raft request' (duration: 413.558556ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:41:40.85762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:41:40.443591Z","time spent":"413.946403ms","remote":"127.0.0.1:34824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:41:40.857707Z","caller":"traceutil/trace.go:171","msg":"trace[1110183190] linearizableReadLoop","detail":"{readStateIndex:26383; appliedIndex:26382; }","duration":"406.789518ms","start":"2026-10-17T11:41:40.450882Z","end":"2026-10-17T11:41:40.857671Z","steps":["trace[1110183190] 'read index received' (duration: 112.389611ms)","trace[1110183190] 'applied index is now lower than readState.Index' (duration: 294.398217ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:41:40.857892Z","caller":"traceutil/trace.go:171","msg":"trace[2050110238] transaction","detail":"{read_only:false; response_revision:25549; number_of_response:1; }","duration":"349.506656ms","start":"2026-10-17T11:41:40.508371Z","end":"2026-10-17T11:41:40.857878Z","steps":["trace[2050110238] 'process raft request' (duration: 348.980986ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:41:40.858063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:41:40.508351Z","time spent":"349.582719ms","remote":"127.0.0.1:34824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:41:40.858234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.786446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:41:40.858277Z","caller":"traceutil/trace.go:171","msg":"trace[1629114589] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:25549; }","duration":"221.866108ms","start":"2026-10-17T11:41:40.636397Z","end":"2026-10-17T11:41:40.858263Z","steps":["trace[1629114589] 'agreement among raft nodes before linearized reading' (duration: 221.796526ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:41:40.858348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.298968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-17T11:41:40.858457Z","caller":"traceutil/trace.go:171","msg":"trace[375362708] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25549; }","duration":"407.575953ms","start":"2026-10-17T11:41:40.450856Z","end":"2026-10-17T11:41:40.858432Z","steps":["trace[375362708] 'agreement among raft nodes before linearized reading' (duration: 407.188566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:41:40.858503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:41:40.450844Z","time spent":"407.649375ms","remote":"127.0.0.1:34824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-17T11:41:40.858069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.948195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:41:40.858717Z","caller":"traceutil/trace.go:171","msg":"trace[2116014065] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:25549; }","duration":"350.593058ms","start":"2026-10-17T11:41:40.508083Z","end":"2026-10-17T11:41:40.858676Z","steps":["trace[2116014065] 'agreement among raft nodes before linearized reading' (duration: 349.817503ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:41:40.858785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:41:40.508018Z","time spent":"350.7379ms","remote":"127.0.0.1:60606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-10-17T11:41:41.258568Z","caller":"traceutil/trace.go:171","msg":"trace[1665452604] transaction","detail":"{read_only:false; response_revision:25555; number_of_response:1; }","duration":"229.985441ms","start":"2026-10-17T11:41:41.028558Z","end":"2026-10-17T11:41:41.258544Z","steps":["trace[1665452604] 'process raft request' (duration: 229.828768ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:41:52.663536Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22226} {"level":"info","ts":"2026-10-17T11:41:52.777711Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22226,"took":"108.197812ms","hash":1227433290,"current-db-size-bytes":58638336,"current-db-size":"59 MB","current-db-size-in-use-bytes":44830720,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-17T11:41:52.777787Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1227433290,"revision":22226,"compact-revision":19998} {"level":"info","ts":"2026-10-17T11:46:52.670874Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25634} {"level":"info","ts":"2026-10-17T11:46:52.834706Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25634,"took":"159.440884ms","hash":2979704260,"current-db-size-bytes":60329984,"current-db-size":"60 MB","current-db-size-in-use-bytes":35909632,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-17T11:46:52.834778Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2979704260,"revision":25634,"compact-revision":22226} {"level":"info","ts":"2026-10-17T11:48:10.346797Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"905ccde8a677f143","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:48:10.353588Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-17T11:48:10.353714Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-17T11:51:52.67871Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28510} {"level":"info","ts":"2026-10-17T11:51:52.827339Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28510,"took":"143.269397ms","hash":3461733449,"current-db-size-bytes":60329984,"current-db-size":"60 MB","current-db-size-in-use-bytes":30482432,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:51:52.827418Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3461733449,"revision":28510,"compact-revision":25634} {"level":"info","ts":"2026-10-17T11:56:52.686453Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30729} {"level":"info","ts":"2026-10-17T11:56:52.804778Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30729,"took":"113.778766ms","hash":2289528551,"current-db-size-bytes":60329984,"current-db-size":"60 MB","current-db-size-in-use-bytes":31395840,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:56:52.804872Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2289528551,"revision":30729,"compact-revision":28510} {"level":"info","ts":"2026-10-17T12:01:52.69668Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32989} {"level":"info","ts":"2026-10-17T12:01:52.844195Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32989,"took":"142.82222ms","hash":4164215430,"current-db-size-bytes":61374464,"current-db-size":"61 MB","current-db-size-in-use-bytes":31633408,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:01:52.844266Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4164215430,"revision":32989,"compact-revision":30729} {"level":"info","ts":"2026-10-17T12:06:52.703973Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35380} {"level":"info","ts":"2026-10-17T12:06:52.851411Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35380,"took":"142.922632ms","hash":2129686229,"current-db-size-bytes":61374464,"current-db-size":"61 MB","current-db-size-in-use-bytes":32067584,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:06:52.851505Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2129686229,"revision":35380,"compact-revision":32989} {"level":"info","ts":"2026-10-17T12:09:24.691845Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"905ccde8a677f143","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:09:24.698885Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-17T12:09:24.698991Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-17T12:11:52.712571Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37639} {"level":"info","ts":"2026-10-17T12:11:52.842623Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37639,"took":"125.619013ms","hash":3996106026,"current-db-size-bytes":61374464,"current-db-size":"61 MB","current-db-size-in-use-bytes":32862208,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T12:11:52.842702Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3996106026,"revision":37639,"compact-revision":35380}