{"level":"warn","ts":"2026-03-29T01:54:39.134655Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-29T01:54:39.134796Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204: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.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204: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-03-29T01:54:39.134881Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-29T01:54:39.134909Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-03-29T01:54:39.134939Z","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-03-29T01:54:39.135566Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]} {"level":"info","ts":"2026-03-29T01:54:39.135663Z","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.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204: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-03-29T01:54:39.14058Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.667596ms"} {"level":"info","ts":"2026-03-29T01:54:39.148689Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"} {"level":"info","ts":"2026-03-29T01:54:39.14882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"} {"level":"info","ts":"2026-03-29T01:54:39.148849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"} {"level":"info","ts":"2026-03-29T01:54:39.148871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-29T01:54:39.148893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"} {"level":"info","ts":"2026-03-29T01:54:39.148948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"warn","ts":"2026-03-29T01:54:39.156805Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-29T01:54:39.15835Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-29T01:54:39.159875Z","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-03-29T01:54:39.162399Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-29T01:54:39.162614Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-29T01:54:39.162735Z","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-03-29T01:54:39.162863Z","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-03-29T01:54:39.162876Z","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-03-29T01:54:39.16428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"info","ts":"2026-03-29T01:54:39.16454Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-03-29T01:54:39.166651Z","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-03-29T01:54:39.166769Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-03-29T01:54:39.166837Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-03-29T01:54:39.166914Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-29T01:54:39.166947Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-29T01:54:39.349836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"} {"level":"info","ts":"2026-03-29T01:54:39.349908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-29T01:54:39.349934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"} {"level":"info","ts":"2026-03-29T01:54:39.349956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"} {"level":"info","ts":"2026-03-29T01:54:39.349968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-03-29T01:54:39.349984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"} {"level":"info","ts":"2026-03-29T01:54:39.349999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-03-29T01:54:39.35082Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-29T01:54:39.351515Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"} {"level":"info","ts":"2026-03-29T01:54:39.351554Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-29T01:54:39.351605Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-29T01:54:39.351796Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-29T01:54:39.351817Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-29T01:54:39.351877Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"} {"level":"info","ts":"2026-03-29T01:54:39.351986Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-29T01:54:39.352021Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-29T01:54:39.355012Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"} {"level":"info","ts":"2026-03-29T01:54:39.356261Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-29T01:55:01.188328Z","caller":"traceutil/trace.go:171","msg":"trace[1298712101] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"116.621943ms","start":"2026-03-29T01:55:01.071671Z","end":"2026-03-29T01:55:01.188293Z","steps":["trace[1298712101] 'process raft request' (duration: 116.365698ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:55:06.512234Z","caller":"traceutil/trace.go:171","msg":"trace[1735139539] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"134.633303ms","start":"2026-03-29T01:55:06.377552Z","end":"2026-03-29T01:55:06.512185Z","steps":["trace[1735139539] 'process raft request' (duration: 134.405009ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T01:55:11.276988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.665336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-29T01:55:11.277168Z","caller":"traceutil/trace.go:171","msg":"trace[1088322552] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"320.607462ms","start":"2026-03-29T01:55:10.956536Z","end":"2026-03-29T01:55:11.277144Z","steps":["trace[1088322552] 'read index received' (duration: 67.906035ms)","trace[1088322552] 'applied index is now lower than readState.Index' (duration: 252.699717ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T01:55:11.277246Z","caller":"traceutil/trace.go:171","msg":"trace[483675096] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"331.129242ms","start":"2026-03-29T01:55:10.946065Z","end":"2026-03-29T01:55:11.277195Z","steps":["trace[483675096] 'process raft request' (duration: 78.527287ms)","trace[483675096] 'compare' (duration: 251.271898ms)"],"step_count":2} {"level":"warn","ts":"2026-03-29T01:55:11.277386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.842637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-03-29T01:55:11.277431Z","caller":"traceutil/trace.go:171","msg":"trace[44103257] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:585; }","duration":"320.931848ms","start":"2026-03-29T01:55:10.956485Z","end":"2026-03-29T01:55:11.277417Z","steps":["trace[44103257] 'agreement among raft nodes before linearized reading' (duration: 320.751605ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T01:55:11.277527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T01:55:10.956463Z","time spent":"321.050741ms","remote":"127.0.0.1:47660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":31150,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-03-29T01:55:11.277529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T01:55:10.946037Z","time spent":"331.326305ms","remote":"127.0.0.1:47660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-29T01:55:11.286036Z","caller":"traceutil/trace.go:171","msg":"trace[1760935475] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"288.657936ms","start":"2026-03-29T01:55:10.997357Z","end":"2026-03-29T01:55:11.286015Z","steps":["trace[1760935475] 'process raft request' (duration: 288.125805ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:55:15.832511Z","caller":"traceutil/trace.go:171","msg":"trace[1921263108] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"153.622021ms","start":"2026-03-29T01:55:15.678865Z","end":"2026-03-29T01:55:15.832487Z","steps":["trace[1921263108] 'process raft request' (duration: 153.10434ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:55:16.341356Z","caller":"traceutil/trace.go:171","msg":"trace[690158058] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"177.53345ms","start":"2026-03-29T01:55:16.163788Z","end":"2026-03-29T01:55:16.341321Z","steps":["trace[690158058] 'read index received' (duration: 177.289115ms)","trace[690158058] 'applied index is now lower than readState.Index' (duration: 242.285µs)"],"step_count":2} {"level":"info","ts":"2026-03-29T01:55:16.341409Z","caller":"traceutil/trace.go:171","msg":"trace[481173217] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"447.048296ms","start":"2026-03-29T01:55:15.894317Z","end":"2026-03-29T01:55:16.341365Z","steps":["trace[481173217] 'process raft request' (duration: 446.789421ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T01:55:16.341633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T01:55:15.894279Z","time spent":"447.21148ms","remote":"127.0.0.1:47964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-29T01:55:16.341732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.926228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-trnrd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-29T01:55:16.341829Z","caller":"traceutil/trace.go:171","msg":"trace[853064313] range","detail":"{range_begin:/registry/pods/kube-system/cilium-trnrd; range_end:; response_count:1; response_revision:617; }","duration":"178.131862ms","start":"2026-03-29T01:55:16.163672Z","end":"2026-03-29T01:55:16.341804Z","steps":["trace[853064313] 'agreement among raft nodes before linearized reading' (duration: 177.769615ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:56:21.627456Z","caller":"traceutil/trace.go:171","msg":"trace[845038925] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"124.053008ms","start":"2026-03-29T01:56:21.503357Z","end":"2026-03-29T01:56:21.62741Z","steps":["trace[845038925] 'process raft request' (duration: 117.976239ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:56:58.793989Z","caller":"traceutil/trace.go:171","msg":"trace[1936646518] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"117.667853ms","start":"2026-03-29T01:56:58.676285Z","end":"2026-03-29T01:56:58.793953Z","steps":["trace[1936646518] 'process raft request' (duration: 117.454879ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T01:57:53.35894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.30107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-03-29T01:57:53.359046Z","caller":"traceutil/trace.go:171","msg":"trace[1704880745] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2232; }","duration":"165.453333ms","start":"2026-03-29T01:57:53.193563Z","end":"2026-03-29T01:57:53.359017Z","steps":["trace[1704880745] 'range keys from in-memory index tree' (duration: 165.080575ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:57:53.541113Z","caller":"traceutil/trace.go:171","msg":"trace[2090185204] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"107.010308ms","start":"2026-03-29T01:57:53.434058Z","end":"2026-03-29T01:57:53.541068Z","steps":["trace[2090185204] 'process raft request' (duration: 40.797271ms)","trace[2090185204] 'compare' (duration: 66.005673ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T01:57:53.698702Z","caller":"traceutil/trace.go:171","msg":"trace[2117636142] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"153.086752ms","start":"2026-03-29T01:57:53.545586Z","end":"2026-03-29T01:57:53.698673Z","steps":["trace[2117636142] 'process raft request' (duration: 150.758673ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:02:48.428654Z","caller":"traceutil/trace.go:171","msg":"trace[1660148341] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"101.730596ms","start":"2026-03-29T02:02:48.3269Z","end":"2026-03-29T02:02:48.428631Z","steps":["trace[1660148341] 'process raft request' (duration: 101.410749ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:02:48.430676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.165855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:10 size:76268"} {"level":"info","ts":"2026-03-29T02:02:48.430838Z","caller":"traceutil/trace.go:171","msg":"trace[397429595] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:10; response_revision:4720; }","duration":"101.377119ms","start":"2026-03-29T02:02:48.329435Z","end":"2026-03-29T02:02:48.430812Z","steps":["trace[397429595] 'agreement among raft nodes before linearized reading' (duration: 99.05226ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:02:55.988011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.119258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-29T02:02:55.988157Z","caller":"traceutil/trace.go:171","msg":"trace[1435422165] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"157.047624ms","start":"2026-03-29T02:02:55.831064Z","end":"2026-03-29T02:02:55.988112Z","steps":["trace[1435422165] 'process raft request' (duration: 23.759402ms)","trace[1435422165] 'compare' (duration: 133.017096ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:02:56.340072Z","caller":"traceutil/trace.go:171","msg":"trace[1262110504] linearizableReadLoop","detail":"{readStateIndex:5142; appliedIndex:5141; }","duration":"127.600133ms","start":"2026-03-29T02:02:56.212448Z","end":"2026-03-29T02:02:56.340048Z","steps":["trace[1262110504] 'read index received' (duration: 63.873938ms)","trace[1262110504] 'applied index is now lower than readState.Index' (duration: 63.721485ms)"],"step_count":2} {"level":"warn","ts":"2026-03-29T02:02:56.340215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.748516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T02:02:56.340245Z","caller":"traceutil/trace.go:171","msg":"trace[600732411] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4953; }","duration":"127.864999ms","start":"2026-03-29T02:02:56.212369Z","end":"2026-03-29T02:02:56.340234Z","steps":["trace[600732411] 'agreement among raft nodes before linearized reading' (duration: 127.796508ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:02:56.340234Z","caller":"traceutil/trace.go:171","msg":"trace[897614597] transaction","detail":"{read_only:false; response_revision:4953; number_of_response:1; }","duration":"147.786168ms","start":"2026-03-29T02:02:56.192419Z","end":"2026-03-29T02:02:56.340205Z","steps":["trace[897614597] 'process raft request' (duration: 83.846459ms)","trace[897614597] 'compare' (duration: 63.48739ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:03:05.886705Z","caller":"traceutil/trace.go:171","msg":"trace[90069272] linearizableReadLoop","detail":"{readStateIndex:5373; appliedIndex:5372; }","duration":"108.696254ms","start":"2026-03-29T02:03:05.777981Z","end":"2026-03-29T02:03:05.886677Z","steps":["trace[90069272] 'read index received' (duration: 108.265745ms)","trace[90069272] 'applied index is now lower than readState.Index' (duration: 429.629µs)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:03:05.886783Z","caller":"traceutil/trace.go:171","msg":"trace[2080369070] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"118.468469ms","start":"2026-03-29T02:03:05.76828Z","end":"2026-03-29T02:03:05.886748Z","steps":["trace[2080369070] 'process raft request' (duration: 118.087821ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:03:05.886987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.97666ms","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-03-29T02:03:05.88704Z","caller":"traceutil/trace.go:171","msg":"trace[983370941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5176; }","duration":"109.063652ms","start":"2026-03-29T02:03:05.777963Z","end":"2026-03-29T02:03:05.887026Z","steps":["trace[983370941] 'agreement among raft nodes before linearized reading' (duration: 108.828117ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:03:14.580474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.42537ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-29T02:03:14.580591Z","caller":"traceutil/trace.go:171","msg":"trace[2020161831] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"153.048029ms","start":"2026-03-29T02:03:14.427523Z","end":"2026-03-29T02:03:14.580571Z","steps":["trace[2020161831] 'process raft request' (duration: 33.395524ms)","trace[2020161831] 'compare' (duration: 119.165805ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:03:15.478005Z","caller":"traceutil/trace.go:171","msg":"trace[474112559] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"103.271409ms","start":"2026-03-29T02:03:15.374697Z","end":"2026-03-29T02:03:15.477968Z","steps":["trace[474112559] 'process raft request' (duration: 100.082362ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:03:25.04417Z","caller":"traceutil/trace.go:171","msg":"trace[1007520569] transaction","detail":"{read_only:false; response_revision:5507; number_of_response:1; }","duration":"159.411583ms","start":"2026-03-29T02:03:24.884736Z","end":"2026-03-29T02:03:25.044148Z","steps":["trace[1007520569] 'process raft request' (duration: 159.195679ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:03:25.04418Z","caller":"traceutil/trace.go:171","msg":"trace[1590925670] linearizableReadLoop","detail":"{readStateIndex:5711; appliedIndex:5710; }","duration":"133.140799ms","start":"2026-03-29T02:03:24.911011Z","end":"2026-03-29T02:03:25.044152Z","steps":["trace[1590925670] 'read index received' (duration: 132.884234ms)","trace[1590925670] 'applied index is now lower than readState.Index' (duration: 225.105µs)"],"step_count":2} {"level":"warn","ts":"2026-03-29T02:03:25.044492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.422566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-03-29T02:03:25.044592Z","caller":"traceutil/trace.go:171","msg":"trace[1841853522] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5507; }","duration":"133.600739ms","start":"2026-03-29T02:03:24.910976Z","end":"2026-03-29T02:03:25.044576Z","steps":["trace[1841853522] 'agreement among raft nodes before linearized reading' (duration: 133.284933ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:04:39.433394Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3009} {"level":"info","ts":"2026-03-29T02:04:39.533737Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3009,"took":"98.226605ms","hash":2160762762,"current-db-size-bytes":58327040,"current-db-size":"58 MB","current-db-size-in-use-bytes":31731712,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-03-29T02:04:39.533832Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2160762762,"revision":3009,"compact-revision":-1} {"level":"info","ts":"2026-03-29T02:09:01.237376Z","caller":"traceutil/trace.go:171","msg":"trace[230535328] transaction","detail":"{read_only:false; response_revision:8088; number_of_response:1; }","duration":"365.046885ms","start":"2026-03-29T02:09:00.872277Z","end":"2026-03-29T02:09:01.237324Z","steps":["trace[230535328] 'process raft request' (duration: 286.309192ms)","trace[230535328] 'compare' (duration: 78.533789ms)"],"step_count":2} {"level":"warn","ts":"2026-03-29T02:09:01.237573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T02:09:00.872264Z","time spent":"365.215898ms","remote":"127.0.0.1:47882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-29T02:09:12.456061Z","caller":"traceutil/trace.go:171","msg":"trace[2080211346] transaction","detail":"{read_only:false; response_revision:8144; number_of_response:1; }","duration":"170.211574ms","start":"2026-03-29T02:09:12.285823Z","end":"2026-03-29T02:09:12.456034Z","steps":["trace[2080211346] 'process raft request' (duration: 170.061501ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:12.467186Z","caller":"traceutil/trace.go:171","msg":"trace[468556711] transaction","detail":"{read_only:false; response_revision:8145; number_of_response:1; }","duration":"131.191565ms","start":"2026-03-29T02:09:12.335968Z","end":"2026-03-29T02:09:12.46716Z","steps":["trace[468556711] 'process raft request' (duration: 131.060021ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:13.090089Z","caller":"traceutil/trace.go:171","msg":"trace[553467415] transaction","detail":"{read_only:false; response_revision:8149; number_of_response:1; }","duration":"154.260699ms","start":"2026-03-29T02:09:12.93579Z","end":"2026-03-29T02:09:13.090051Z","steps":["trace[553467415] 'process raft request' (duration: 154.064935ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:13.431508Z","caller":"traceutil/trace.go:171","msg":"trace[907057902] linearizableReadLoop","detail":"{readStateIndex:8438; appliedIndex:8437; }","duration":"125.455244ms","start":"2026-03-29T02:09:13.306025Z","end":"2026-03-29T02:09:13.43148Z","steps":["trace[907057902] 'read index received' (duration: 125.27301ms)","trace[907057902] 'applied index is now lower than readState.Index' (duration: 180.924µs)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:09:13.431581Z","caller":"traceutil/trace.go:171","msg":"trace[137538242] transaction","detail":"{read_only:false; response_revision:8150; number_of_response:1; }","duration":"143.469982ms","start":"2026-03-29T02:09:13.288062Z","end":"2026-03-29T02:09:13.431532Z","steps":["trace[137538242] 'process raft request' (duration: 143.257318ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:13.431719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.665388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-29T02:09:13.431769Z","caller":"traceutil/trace.go:171","msg":"trace[723374429] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:8150; }","duration":"125.73353ms","start":"2026-03-29T02:09:13.30602Z","end":"2026-03-29T02:09:13.431754Z","steps":["trace[723374429] 'agreement among raft nodes before linearized reading' (duration: 125.622478ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:13.431847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.368459ms","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-03-29T02:09:13.431947Z","caller":"traceutil/trace.go:171","msg":"trace[1577898385] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8150; }","duration":"111.503961ms","start":"2026-03-29T02:09:13.320422Z","end":"2026-03-29T02:09:13.431926Z","steps":["trace[1577898385] 'agreement among raft nodes before linearized reading' (duration: 111.230916ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:14.638266Z","caller":"traceutil/trace.go:171","msg":"trace[1584331967] transaction","detail":"{read_only:false; response_revision:8156; number_of_response:1; }","duration":"166.161689ms","start":"2026-03-29T02:09:14.472073Z","end":"2026-03-29T02:09:14.638235Z","steps":["trace[1584331967] 'process raft request' (duration: 131.4394ms)","trace[1584331967] 'compare' (duration: 34.598407ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:09:39.443378Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6122} {"level":"info","ts":"2026-03-29T02:09:39.535087Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6122,"took":"90.147682ms","hash":1751732434,"current-db-size-bytes":58327040,"current-db-size":"58 MB","current-db-size-in-use-bytes":23261184,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-29T02:09:39.535165Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1751732434,"revision":6122,"compact-revision":3009} {"level":"info","ts":"2026-03-29T02:09:46.33183Z","caller":"traceutil/trace.go:171","msg":"trace[1611038147] transaction","detail":"{read_only:false; response_revision:8382; number_of_response:1; }","duration":"123.248068ms","start":"2026-03-29T02:09:46.208536Z","end":"2026-03-29T02:09:46.331784Z","steps":["trace[1611038147] 'process raft request' (duration: 123.012573ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:58.192607Z","caller":"traceutil/trace.go:171","msg":"trace[2113476737] linearizableReadLoop","detail":"{readStateIndex:8788; appliedIndex:8787; }","duration":"285.310161ms","start":"2026-03-29T02:09:57.907272Z","end":"2026-03-29T02:09:58.192582Z","steps":["trace[2113476737] 'read index received' (duration: 235.322061ms)","trace[2113476737] 'applied index is now lower than readState.Index' (duration: 49.98714ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:09:58.192716Z","caller":"traceutil/trace.go:171","msg":"trace[1235940906] transaction","detail":"{read_only:false; response_revision:8484; number_of_response:1; }","duration":"285.521185ms","start":"2026-03-29T02:09:57.907173Z","end":"2026-03-29T02:09:58.192694Z","steps":["trace[1235940906] 'process raft request' (duration: 235.469044ms)","trace[1235940906] 'compare' (duration: 49.846997ms)"],"step_count":2} {"level":"warn","ts":"2026-03-29T02:09:58.192834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.538855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-lfpqd\" ","response":"range_response_count:1 size:4665"} {"level":"info","ts":"2026-03-29T02:09:58.192875Z","caller":"traceutil/trace.go:171","msg":"trace[949733388] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-lfpqd; range_end:; response_count:1; response_revision:8484; }","duration":"285.630257ms","start":"2026-03-29T02:09:57.907234Z","end":"2026-03-29T02:09:58.192864Z","steps":["trace[949733388] 'agreement among raft nodes before linearized reading' (duration: 285.470154ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:58.261213Z","caller":"traceutil/trace.go:171","msg":"trace[743355449] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"241.262997ms","start":"2026-03-29T02:09:58.019932Z","end":"2026-03-29T02:09:58.261195Z","steps":["trace[743355449] 'process raft request' (duration: 241.153344ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:58.261401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.85755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-c945w\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-03-29T02:09:58.261444Z","caller":"traceutil/trace.go:171","msg":"trace[1786201397] range","detail":"{range_begin:/registry/pods/openstack/keepalived-c945w; range_end:; response_count:1; response_revision:8485; }","duration":"304.961813ms","start":"2026-03-29T02:09:57.956471Z","end":"2026-03-29T02:09:58.261433Z","steps":["trace[1786201397] 'agreement among raft nodes before linearized reading' (duration: 304.830111ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:58.261483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T02:09:57.956446Z","time spent":"305.027304ms","remote":"127.0.0.1:47804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-c945w\" "} {"level":"warn","ts":"2026-03-29T02:09:58.261508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.537942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-lfpqd\" ","response":"range_response_count:1 size:4665"} {"level":"info","ts":"2026-03-29T02:09:58.261613Z","caller":"traceutil/trace.go:171","msg":"trace[124567089] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-lfpqd; range_end:; response_count:1; response_revision:8485; }","duration":"241.705016ms","start":"2026-03-29T02:09:58.019884Z","end":"2026-03-29T02:09:58.261589Z","steps":["trace[124567089] 'agreement among raft nodes before linearized reading' (duration: 241.368629ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:58.261644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.906401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-lfpqd\" ","response":"range_response_count:1 size:4665"} {"level":"info","ts":"2026-03-29T02:09:58.261739Z","caller":"traceutil/trace.go:171","msg":"trace[2084905119] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-lfpqd; range_end:; response_count:1; response_revision:8485; }","duration":"354.059344ms","start":"2026-03-29T02:09:57.907659Z","end":"2026-03-29T02:09:58.261719Z","steps":["trace[2084905119] 'agreement among raft nodes before linearized reading' (duration: 353.786519ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:58.261788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T02:09:57.90764Z","time spent":"354.140057ms","remote":"127.0.0.1:47804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":4689,"request content":"key:\"/registry/pods/openstack/rook-ceph-detect-version-lfpqd\" "} {"level":"info","ts":"2026-03-29T02:09:58.405025Z","caller":"traceutil/trace.go:171","msg":"trace[307374568] linearizableReadLoop","detail":"{readStateIndex:8790; appliedIndex:8789; }","duration":"143.786398ms","start":"2026-03-29T02:09:58.261203Z","end":"2026-03-29T02:09:58.40499Z","steps":["trace[307374568] 'read index received' (duration: 93.38398ms)","trace[307374568] 'applied index is now lower than readState.Index' (duration: 50.401078ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:09:58.405128Z","caller":"traceutil/trace.go:171","msg":"trace[1352144437] transaction","detail":"{read_only:false; response_revision:8486; number_of_response:1; }","duration":"204.171908ms","start":"2026-03-29T02:09:58.200917Z","end":"2026-03-29T02:09:58.405089Z","steps":["trace[1352144437] 'process raft request' (duration: 153.552475ms)","trace[1352144437] 'compare' (duration: 50.342407ms)"],"step_count":2} {"level":"warn","ts":"2026-03-29T02:09:58.405218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.07233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-29T02:09:58.405294Z","caller":"traceutil/trace.go:171","msg":"trace[264067187] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:8486; }","duration":"209.240803ms","start":"2026-03-29T02:09:58.196036Z","end":"2026-03-29T02:09:58.405277Z","steps":["trace[264067187] 'agreement among raft nodes before linearized reading' (duration: 209.08141ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:58.405428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.078019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-29T02:09:58.405425Z","caller":"traceutil/trace.go:171","msg":"trace[1810520118] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8486; }","duration":"134.585175ms","start":"2026-03-29T02:09:58.270787Z","end":"2026-03-29T02:09:58.405372Z","steps":["trace[1810520118] 'process raft request' (duration: 134.354551ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:58.405495Z","caller":"traceutil/trace.go:171","msg":"trace[209082760] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:8486; }","duration":"128.189482ms","start":"2026-03-29T02:09:58.277289Z","end":"2026-03-29T02:09:58.405479Z","steps":["trace[209082760] 'agreement among raft nodes before linearized reading' (duration: 127.966197ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:58.405671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.949016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228453"} {"level":"info","ts":"2026-03-29T02:09:58.405767Z","caller":"traceutil/trace.go:171","msg":"trace[312293712] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8486; }","duration":"138.089059ms","start":"2026-03-29T02:09:58.267659Z","end":"2026-03-29T02:09:58.405748Z","steps":["trace[312293712] 'agreement among raft nodes before linearized reading' (duration: 137.580079ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:58.405887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.170261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-lfpqd\" ","response":"range_response_count:1 size:2803"} {"level":"info","ts":"2026-03-29T02:09:58.406041Z","caller":"traceutil/trace.go:171","msg":"trace[2054917267] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-lfpqd; range_end:; response_count:1; response_revision:8486; }","duration":"138.301144ms","start":"2026-03-29T02:09:58.267662Z","end":"2026-03-29T02:09:58.405963Z","steps":["trace[2054917267] 'agreement among raft nodes before linearized reading' (duration: 137.62723ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:59.122074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.036018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-29T02:09:59.122181Z","caller":"traceutil/trace.go:171","msg":"trace[2098487108] transaction","detail":"{read_only:false; response_revision:8491; number_of_response:1; }","duration":"318.261933ms","start":"2026-03-29T02:09:58.8039Z","end":"2026-03-29T02:09:59.122162Z","steps":["trace[2098487108] 'process raft request' (duration: 50.069021ms)","trace[2098487108] 'compare' (duration: 267.816094ms)"],"step_count":2} {"level":"warn","ts":"2026-03-29T02:09:59.122412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T02:09:58.80389Z","time spent":"318.461257ms","remote":"127.0.0.1:47714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":583,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-29T02:09:59.192504Z","caller":"traceutil/trace.go:171","msg":"trace[1566896530] transaction","detail":"{read_only:false; response_revision:8492; number_of_response:1; }","duration":"357.213981ms","start":"2026-03-29T02:09:58.835259Z","end":"2026-03-29T02:09:59.192473Z","steps":["trace[1566896530] 'process raft request' (duration: 356.993206ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:59.192596Z","caller":"traceutil/trace.go:171","msg":"trace[1176610429] transaction","detail":"{read_only:false; response_revision:8493; number_of_response:1; }","duration":"348.928727ms","start":"2026-03-29T02:09:58.843642Z","end":"2026-03-29T02:09:59.19257Z","steps":["trace[1176610429] 'process raft request' (duration: 348.778254ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:59.192683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T02:09:58.835233Z","time spent":"357.362093ms","remote":"127.0.0.1:47882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-29T02:09:59.19274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T02:09:58.843621Z","time spent":"349.038729ms","remote":"127.0.0.1:47866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-29T02:09:59.199979Z","caller":"traceutil/trace.go:171","msg":"trace[865105250] linearizableReadLoop","detail":"{readStateIndex:8799; appliedIndex:8796; }","duration":"185.483696ms","start":"2026-03-29T02:09:59.014477Z","end":"2026-03-29T02:09:59.199961Z","steps":["trace[865105250] 'read index received' (duration: 177.759943ms)","trace[865105250] 'applied index is now lower than readState.Index' (duration: 7.722583ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:09:59.20008Z","caller":"traceutil/trace.go:171","msg":"trace[1007163549] transaction","detail":"{read_only:false; response_revision:8494; number_of_response:1; }","duration":"294.678897ms","start":"2026-03-29T02:09:58.905393Z","end":"2026-03-29T02:09:59.200072Z","steps":["trace[1007163549] 'process raft request' (duration: 294.451692ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:59.200492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.003926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-29T02:09:59.200568Z","caller":"traceutil/trace.go:171","msg":"trace[846242642] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:8494; }","duration":"186.122849ms","start":"2026-03-29T02:09:59.014428Z","end":"2026-03-29T02:09:59.200551Z","steps":["trace[846242642] 'agreement among raft nodes before linearized reading' (duration: 186.001406ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:59.200588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.811106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-03-29T02:09:59.200684Z","caller":"traceutil/trace.go:171","msg":"trace[28372559] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8494; }","duration":"139.983749ms","start":"2026-03-29T02:09:59.060679Z","end":"2026-03-29T02:09:59.200663Z","steps":["trace[28372559] 'agreement among raft nodes before linearized reading' (duration: 139.729234ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:59.200748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.611081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-03-29T02:09:59.200969Z","caller":"traceutil/trace.go:171","msg":"trace[1100433046] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8494; }","duration":"140.252975ms","start":"2026-03-29T02:09:59.060694Z","end":"2026-03-29T02:09:59.200947Z","steps":["trace[1100433046] 'agreement among raft nodes before linearized reading' (duration: 139.51131ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:59.822881Z","caller":"traceutil/trace.go:171","msg":"trace[570643051] linearizableReadLoop","detail":"{readStateIndex:8804; appliedIndex:8803; }","duration":"168.473007ms","start":"2026-03-29T02:09:59.654382Z","end":"2026-03-29T02:09:59.822855Z","steps":["trace[570643051] 'read index received' (duration: 168.232782ms)","trace[570643051] 'applied index is now lower than readState.Index' (duration: 239.125µs)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:09:59.822959Z","caller":"traceutil/trace.go:171","msg":"trace[1220726055] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"175.878503ms","start":"2026-03-29T02:09:59.647038Z","end":"2026-03-29T02:09:59.822916Z","steps":["trace[1220726055] 'process raft request' (duration: 175.655389ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:59.823118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.724493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-03-29T02:09:59.823148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.454196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-29T02:09:59.823178Z","caller":"traceutil/trace.go:171","msg":"trace[1140453511] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8499; }","duration":"168.833174ms","start":"2026-03-29T02:09:59.654331Z","end":"2026-03-29T02:09:59.823164Z","steps":["trace[1140453511] 'agreement among raft nodes before linearized reading' (duration: 168.62421ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:59.823192Z","caller":"traceutil/trace.go:171","msg":"trace[272431467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8499; }","duration":"168.542649ms","start":"2026-03-29T02:09:59.654634Z","end":"2026-03-29T02:09:59.823177Z","steps":["trace[272431467] 'agreement among raft nodes before linearized reading' (duration: 168.373385ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:10:53.97882Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024af.wal"} {"level":"info","ts":"2026-03-29T02:11:06.325509Z","caller":"traceutil/trace.go:171","msg":"trace[436232307] transaction","detail":"{read_only:false; response_revision:9191; number_of_response:1; }","duration":"119.169562ms","start":"2026-03-29T02:11:06.206313Z","end":"2026-03-29T02:11:06.325483Z","steps":["trace[436232307] 'process raft request' (duration: 119.006798ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:11:06.350526Z","caller":"traceutil/trace.go:171","msg":"trace[735268715] transaction","detail":"{read_only:false; response_revision:9192; number_of_response:1; }","duration":"144.001743ms","start":"2026-03-29T02:11:06.206503Z","end":"2026-03-29T02:11:06.350505Z","steps":["trace[735268715] 'process raft request' (duration: 143.823589ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:11:06.350694Z","caller":"traceutil/trace.go:171","msg":"trace[2101148503] transaction","detail":"{read_only:false; response_revision:9193; number_of_response:1; }","duration":"142.055472ms","start":"2026-03-29T02:11:06.208629Z","end":"2026-03-29T02:11:06.350685Z","steps":["trace[2101148503] 'process raft request' (duration: 141.815207ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:12:13.941218Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a11c20306510c1f7","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-29T02:12:13.947083Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-29T02:12:13.947231Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-29T02:14:39.450132Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8344} {"level":"info","ts":"2026-03-29T02:14:39.528349Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8344,"took":"76.532365ms","hash":886020927,"current-db-size-bytes":58327040,"current-db-size":"58 MB","current-db-size-in-use-bytes":24530944,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-03-29T02:14:39.528421Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":886020927,"revision":8344,"compact-revision":6122} {"level":"info","ts":"2026-03-29T02:19:39.455866Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10690} {"level":"info","ts":"2026-03-29T02:19:39.53034Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10690,"took":"71.957619ms","hash":794005705,"current-db-size-bytes":58327040,"current-db-size":"58 MB","current-db-size-in-use-bytes":20213760,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-03-29T02:19:39.530392Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":794005705,"revision":10690,"compact-revision":8344}