{"level":"warn","ts":"2026-04-20T20:56:13.768549Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T20:56:13.768642Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T20:56:13.768712Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T20:56:13.768727Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-04-20T20:56:13.768745Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T20:56:13.769368Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-04-20T20:56:13.769443Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T20:56:13.773457Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.777022ms"} {"level":"info","ts":"2026-04-20T20:56:13.77981Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-04-20T20:56:13.779882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T20:56:13.779904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-04-20T20:56:13.779912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T20:56:13.779922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-04-20T20:56:13.779958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-04-20T20:56:13.795079Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T20:56:13.796421Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T20:56:13.797968Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-20T20:56:13.800419Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T20:56:13.800636Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T20:56:13.800782Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T20:56:13.801798Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T20:56:13.801821Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T20:56:13.806502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-04-20T20:56:13.806666Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-04-20T20:56:13.807296Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T20:56:13.807527Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T20:56:13.807555Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T20:56:13.807646Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-04-20T20:56:13.807772Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-04-20T20:56:13.980923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T20:56:13.981005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T20:56:13.981046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-04-20T20:56:13.981074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-04-20T20:56:13.981087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-04-20T20:56:13.98111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-04-20T20:56:13.981128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-04-20T20:56:13.98221Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:56:13.983356Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T20:56:13.983354Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T20:56:13.983404Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T20:56:13.983807Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:56:13.983969Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:56:13.984059Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:56:13.984144Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T20:56:13.984187Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T20:56:13.987185Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T20:56:13.98722Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"warn","ts":"2026-04-20T20:56:32.490441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.689903ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-20T20:56:42.817902Z","caller":"traceutil/trace.go:171","msg":"trace[531684133] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"126.062636ms","start":"2026-04-20T20:56:42.691813Z","end":"2026-04-20T20:56:42.817876Z","steps":["trace[531684133] 'process raft request' (duration: 66.57677ms)","trace[531684133] 'compare' (duration: 59.325373ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:56:42.824417Z","caller":"traceutil/trace.go:171","msg":"trace[12007606] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"116.191872ms","start":"2026-04-20T20:56:42.708208Z","end":"2026-04-20T20:56:42.8244Z","steps":["trace[12007606] 'process raft request' (duration: 115.911506ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:56:42.824569Z","caller":"traceutil/trace.go:171","msg":"trace[2105756445] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"111.829336ms","start":"2026-04-20T20:56:42.71271Z","end":"2026-04-20T20:56:42.82454Z","steps":["trace[2105756445] 'process raft request' (duration: 111.55827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:56:43.234517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.343971ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T20:56:43.234623Z","caller":"traceutil/trace.go:171","msg":"trace[1107940544] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:578; }","duration":"340.088458ms","start":"2026-04-20T20:56:42.89452Z","end":"2026-04-20T20:56:43.234608Z","steps":["trace[1107940544] 'read index received' (duration: 15.857764ms)","trace[1107940544] 'applied index is now lower than readState.Index' (duration: 324.229844ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:56:43.234682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.15992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T20:56:43.234705Z","caller":"traceutil/trace.go:171","msg":"trace[661628532] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"340.204921ms","start":"2026-04-20T20:56:42.894492Z","end":"2026-04-20T20:56:43.234697Z","steps":["trace[661628532] 'agreement among raft nodes before linearized reading' (duration: 340.15729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:56:43.234738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:56:42.894485Z","time spent":"340.244912ms","remote":"127.0.0.1:50954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T20:56:43.234998Z","caller":"traceutil/trace.go:171","msg":"trace[1345634609] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"340.816694ms","start":"2026-04-20T20:56:42.894169Z","end":"2026-04-20T20:56:43.234986Z","steps":["trace[1345634609] 'process raft request' (duration: 46.579984ms)","trace[1345634609] 'compare' (duration: 293.229078ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:56:43.235061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:56:42.894138Z","time spent":"340.891486ms","remote":"127.0.0.1:50978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T20:56:43.245156Z","caller":"traceutil/trace.go:171","msg":"trace[1670086477] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"319.728045ms","start":"2026-04-20T20:56:42.925415Z","end":"2026-04-20T20:56:43.245143Z","steps":["trace[1670086477] 'process raft request' (duration: 319.620242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:56:43.245236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:56:42.925394Z","time spent":"319.799497ms","remote":"127.0.0.1:50978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T20:56:43.254517Z","caller":"traceutil/trace.go:171","msg":"trace[403526068] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"288.877873ms","start":"2026-04-20T20:56:42.965616Z","end":"2026-04-20T20:56:43.254493Z","steps":["trace[403526068] 'process raft request' (duration: 288.436443ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:56:48.786032Z","caller":"traceutil/trace.go:171","msg":"trace[1391112354] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"131.817912ms","start":"2026-04-20T20:56:48.654137Z","end":"2026-04-20T20:56:48.785955Z","steps":["trace[1391112354] 'process raft request' (duration: 131.219009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:56:49.367777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.920146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T20:56:49.368006Z","caller":"traceutil/trace.go:171","msg":"trace[1073091943] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"258.248887ms","start":"2026-04-20T20:56:49.109719Z","end":"2026-04-20T20:56:49.367968Z","steps":["trace[1073091943] 'process raft request' (duration: 40.019823ms)","trace[1073091943] 'compare' (duration: 217.719242ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:58:15.74275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.933425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-20T20:58:15.742873Z","caller":"traceutil/trace.go:171","msg":"trace[915219457] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1826; }","duration":"165.13202ms","start":"2026-04-20T20:58:15.577714Z","end":"2026-04-20T20:58:15.742846Z","steps":["trace[915219457] 'range keys from in-memory index tree' (duration: 164.71232ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:58:16.155489Z","caller":"traceutil/trace.go:171","msg":"trace[1939879205] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"114.796416ms","start":"2026-04-20T20:58:16.040646Z","end":"2026-04-20T20:58:16.155442Z","steps":["trace[1939879205] 'process raft request' (duration: 114.532371ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:58:16.156319Z","caller":"traceutil/trace.go:171","msg":"trace[354744039] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"114.877668ms","start":"2026-04-20T20:58:16.041425Z","end":"2026-04-20T20:58:16.156303Z","steps":["trace[354744039] 'process raft request' (duration: 114.781536ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:59:00.569878Z","caller":"traceutil/trace.go:171","msg":"trace[163199121] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"114.920299ms","start":"2026-04-20T20:59:00.454935Z","end":"2026-04-20T20:59:00.569855Z","steps":["trace[163199121] 'process raft request' (duration: 114.805607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:59:00.780366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.585394ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T20:59:00.780537Z","caller":"traceutil/trace.go:171","msg":"trace[263926389] linearizableReadLoop","detail":"{readStateIndex:2205; appliedIndex:2203; }","duration":"194.337501ms","start":"2026-04-20T20:59:00.586185Z","end":"2026-04-20T20:59:00.780522Z","steps":["trace[263926389] 'read index received' (duration: 21.516733ms)","trace[263926389] 'applied index is now lower than readState.Index' (duration: 172.820028ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:59:00.780567Z","caller":"traceutil/trace.go:171","msg":"trace[448614181] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"325.463065ms","start":"2026-04-20T20:59:00.455081Z","end":"2026-04-20T20:59:00.780544Z","steps":["trace[448614181] 'process raft request' (duration: 152.620127ms)","trace[448614181] 'compare' (duration: 172.47696ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:59:00.780611Z","caller":"traceutil/trace.go:171","msg":"trace[1214883487] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"325.521347ms","start":"2026-04-20T20:59:00.45508Z","end":"2026-04-20T20:59:00.780602Z","steps":["trace[1214883487] 'process raft request' (duration: 325.371943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:59:00.780666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:59:00.455068Z","time spent":"325.563677ms","remote":"127.0.0.1:59756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T20:59:00.780663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:59:00.45507Z","time spent":"325.549787ms","remote":"127.0.0.1:59756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T20:59:00.780892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.702299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T20:59:00.780929Z","caller":"traceutil/trace.go:171","msg":"trace[1066675755] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2128; }","duration":"194.758909ms","start":"2026-04-20T20:59:00.58616Z","end":"2026-04-20T20:59:00.780919Z","steps":["trace[1066675755] 'agreement among raft nodes before linearized reading' (duration: 194.662597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:59:00.781085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.305143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T20:59:00.781374Z","caller":"traceutil/trace.go:171","msg":"trace[1904689719] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2128; }","duration":"102.454906ms","start":"2026-04-20T20:59:00.678716Z","end":"2026-04-20T20:59:00.781171Z","steps":["trace[1904689719] 'agreement among raft nodes before linearized reading' (duration: 102.16942ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:00:28.591781Z","caller":"traceutil/trace.go:171","msg":"trace[54874949] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"122.009436ms","start":"2026-04-20T21:00:28.469744Z","end":"2026-04-20T21:00:28.591753Z","steps":["trace[54874949] 'process raft request' (duration: 121.796482ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:02:54.014255Z","caller":"traceutil/trace.go:171","msg":"trace[343915249] transaction","detail":"{read_only:false; response_revision:3759; number_of_response:1; }","duration":"113.183123ms","start":"2026-04-20T21:02:53.90105Z","end":"2026-04-20T21:02:54.014233Z","steps":["trace[343915249] 'process raft request' (duration: 113.04743ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:02:54.015406Z","caller":"traceutil/trace.go:171","msg":"trace[62666497] transaction","detail":"{read_only:false; response_revision:3761; number_of_response:1; }","duration":"111.732681ms","start":"2026-04-20T21:02:53.90363Z","end":"2026-04-20T21:02:54.015362Z","steps":["trace[62666497] 'process raft request' (duration: 111.636329ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:02:54.016191Z","caller":"traceutil/trace.go:171","msg":"trace[359961938] transaction","detail":"{read_only:false; response_revision:3760; number_of_response:1; }","duration":"113.695073ms","start":"2026-04-20T21:02:53.902473Z","end":"2026-04-20T21:02:54.016168Z","steps":["trace[359961938] 'process raft request' (duration: 112.565259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:04:17.078097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.307363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T21:04:17.078168Z","caller":"traceutil/trace.go:171","msg":"trace[28904557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4942; }","duration":"181.413746ms","start":"2026-04-20T21:04:16.896741Z","end":"2026-04-20T21:04:17.078155Z","steps":["trace[28904557] 'range keys from in-memory index tree' (duration: 181.234112ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:34.487759Z","caller":"traceutil/trace.go:171","msg":"trace[1219335582] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"112.554026ms","start":"2026-04-20T21:04:34.375158Z","end":"2026-04-20T21:04:34.487712Z","steps":["trace[1219335582] 'process raft request' (duration: 100.811517ms)","trace[1219335582] 'compare' (duration: 11.406882ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T21:04:34.536699Z","caller":"traceutil/trace.go:171","msg":"trace[1037900750] transaction","detail":"{read_only:false; response_revision:5311; number_of_response:1; }","duration":"106.14803ms","start":"2026-04-20T21:04:34.430495Z","end":"2026-04-20T21:04:34.536643Z","steps":["trace[1037900750] 'process raft request' (duration: 105.931965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:04:34.770487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.787831ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T21:04:34.770743Z","caller":"traceutil/trace.go:171","msg":"trace[1478777304] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"225.636873ms","start":"2026-04-20T21:04:34.545088Z","end":"2026-04-20T21:04:34.770725Z","steps":["trace[1478777304] 'process raft request' (duration: 225.559011ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:34.770765Z","caller":"traceutil/trace.go:171","msg":"trace[1237724191] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"229.001314ms","start":"2026-04-20T21:04:34.541697Z","end":"2026-04-20T21:04:34.770698Z","steps":["trace[1237724191] 'process raft request' (duration: 115.913807ms)","trace[1237724191] 'compare' (duration: 112.637098ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T21:04:34.770804Z","caller":"traceutil/trace.go:171","msg":"trace[386294422] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"228.669058ms","start":"2026-04-20T21:04:34.54207Z","end":"2026-04-20T21:04:34.770739Z","steps":["trace[386294422] 'process raft request' (duration: 228.523685ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:34.837358Z","caller":"traceutil/trace.go:171","msg":"trace[2037931130] transaction","detail":"{read_only:false; response_revision:5316; number_of_response:1; }","duration":"247.525059ms","start":"2026-04-20T21:04:34.589806Z","end":"2026-04-20T21:04:34.837331Z","steps":["trace[2037931130] 'process raft request' (duration: 247.304895ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:34.837634Z","caller":"traceutil/trace.go:171","msg":"trace[812354660] transaction","detail":"{read_only:false; response_revision:5317; number_of_response:1; }","duration":"241.657205ms","start":"2026-04-20T21:04:34.595965Z","end":"2026-04-20T21:04:34.837622Z","steps":["trace[812354660] 'process raft request' (duration: 241.314528ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:34.837788Z","caller":"traceutil/trace.go:171","msg":"trace[41450246] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"239.922447ms","start":"2026-04-20T21:04:34.597844Z","end":"2026-04-20T21:04:34.837767Z","steps":["trace[41450246] 'process raft request' (duration: 239.664012ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:34.915574Z","caller":"traceutil/trace.go:171","msg":"trace[1962712517] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"134.32479ms","start":"2026-04-20T21:04:34.781222Z","end":"2026-04-20T21:04:34.915546Z","steps":["trace[1962712517] 'process raft request' (duration: 133.312038ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:34.916071Z","caller":"traceutil/trace.go:171","msg":"trace[814792289] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"131.336117ms","start":"2026-04-20T21:04:34.784704Z","end":"2026-04-20T21:04:34.916041Z","steps":["trace[814792289] 'process raft request' (duration: 131.033631ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:34.915929Z","caller":"traceutil/trace.go:171","msg":"trace[1062917330] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"134.34303ms","start":"2026-04-20T21:04:34.781561Z","end":"2026-04-20T21:04:34.915904Z","steps":["trace[1062917330] 'process raft request' (duration: 133.943862ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:44.564266Z","caller":"traceutil/trace.go:171","msg":"trace[1663137188] transaction","detail":"{read_only:false; response_revision:5454; number_of_response:1; }","duration":"135.384802ms","start":"2026-04-20T21:04:44.428864Z","end":"2026-04-20T21:04:44.564249Z","steps":["trace[1663137188] 'process raft request' (duration: 92.311645ms)","trace[1663137188] 'compare' (duration: 42.714959ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T21:04:44.564682Z","caller":"traceutil/trace.go:171","msg":"trace[113330800] transaction","detail":"{read_only:false; response_revision:5455; number_of_response:1; }","duration":"135.73206ms","start":"2026-04-20T21:04:44.428871Z","end":"2026-04-20T21:04:44.564604Z","steps":["trace[113330800] 'process raft request' (duration: 135.333951ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:44.56477Z","caller":"traceutil/trace.go:171","msg":"trace[266623830] transaction","detail":"{read_only:false; response_revision:5457; number_of_response:1; }","duration":"135.355792ms","start":"2026-04-20T21:04:44.429389Z","end":"2026-04-20T21:04:44.564744Z","steps":["trace[266623830] 'process raft request' (duration: 135.221809ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:44.564722Z","caller":"traceutil/trace.go:171","msg":"trace[1624543179] transaction","detail":"{read_only:false; response_revision:5456; number_of_response:1; }","duration":"135.416123ms","start":"2026-04-20T21:04:44.429293Z","end":"2026-04-20T21:04:44.564709Z","steps":["trace[1624543179] 'process raft request' (duration: 135.119967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:04:44.564916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.351142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-20T21:04:44.564708Z","caller":"traceutil/trace.go:171","msg":"trace[885365857] linearizableReadLoop","detail":"{readStateIndex:5651; appliedIndex:5646; }","duration":"135.143488ms","start":"2026-04-20T21:04:44.429539Z","end":"2026-04-20T21:04:44.564682Z","steps":["trace[885365857] 'read index received' (duration: 1.842829ms)","trace[885365857] 'applied index is now lower than readState.Index' (duration: 133.299389ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T21:04:44.565011Z","caller":"traceutil/trace.go:171","msg":"trace[1645349900] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5457; }","duration":"135.434015ms","start":"2026-04-20T21:04:44.429523Z","end":"2026-04-20T21:04:44.564957Z","steps":["trace[1645349900] 'agreement among raft nodes before linearized reading' (duration: 135.242381ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:04:44.607843Z","caller":"traceutil/trace.go:171","msg":"trace[1049920626] transaction","detail":"{read_only:false; response_revision:5458; number_of_response:1; }","duration":"168.170801ms","start":"2026-04-20T21:04:44.439642Z","end":"2026-04-20T21:04:44.607813Z","steps":["trace[1049920626] 'process raft request' (duration: 167.818893ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:06:14.11154Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3047} {"level":"info","ts":"2026-04-20T21:06:14.197158Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3047,"took":"83.921857ms","hash":2062239759,"current-db-size-bytes":58748928,"current-db-size":"59 MB","current-db-size-in-use-bytes":32202752,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-20T21:06:14.197219Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2062239759,"revision":3047,"compact-revision":-1} {"level":"info","ts":"2026-04-20T21:10:25.800483Z","caller":"traceutil/trace.go:171","msg":"trace[1867359020] transaction","detail":"{read_only:false; response_revision:8069; number_of_response:1; }","duration":"142.908281ms","start":"2026-04-20T21:10:25.657546Z","end":"2026-04-20T21:10:25.800454Z","steps":["trace[1867359020] 'process raft request' (duration: 142.736117ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:10:37.334008Z","caller":"traceutil/trace.go:171","msg":"trace[380757086] transaction","detail":"{read_only:false; response_revision:8132; number_of_response:1; }","duration":"152.256653ms","start":"2026-04-20T21:10:37.181721Z","end":"2026-04-20T21:10:37.333977Z","steps":["trace[380757086] 'process raft request' (duration: 91.803166ms)","trace[380757086] 'compare' (duration: 60.296613ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T21:10:38.214073Z","caller":"traceutil/trace.go:171","msg":"trace[1425195291] transaction","detail":"{read_only:false; response_revision:8134; number_of_response:1; }","duration":"172.158052ms","start":"2026-04-20T21:10:38.041881Z","end":"2026-04-20T21:10:38.214039Z","steps":["trace[1425195291] 'process raft request' (duration: 171.953078ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:10:38.238829Z","caller":"traceutil/trace.go:171","msg":"trace[185898326] transaction","detail":"{read_only:false; response_revision:8135; number_of_response:1; }","duration":"184.142092ms","start":"2026-04-20T21:10:38.054666Z","end":"2026-04-20T21:10:38.238808Z","steps":["trace[185898326] 'process raft request' (duration: 184.012049ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:10:38.239048Z","caller":"traceutil/trace.go:171","msg":"trace[1843317809] transaction","detail":"{read_only:false; response_revision:8136; number_of_response:1; }","duration":"119.661308ms","start":"2026-04-20T21:10:38.119378Z","end":"2026-04-20T21:10:38.239039Z","steps":["trace[1843317809] 'process raft request' (duration: 119.394962ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:10:38.239029Z","caller":"traceutil/trace.go:171","msg":"trace[1624312837] linearizableReadLoop","detail":"{readStateIndex:8415; appliedIndex:8412; }","duration":"118.469102ms","start":"2026-04-20T21:10:38.120523Z","end":"2026-04-20T21:10:38.238992Z","steps":["trace[1624312837] 'read index received' (duration: 93.379379ms)","trace[1624312837] 'applied index is now lower than readState.Index' (duration: 25.088203ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T21:10:38.239239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.696797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T21:10:38.239281Z","caller":"traceutil/trace.go:171","msg":"trace[1678999077] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8136; }","duration":"118.780818ms","start":"2026-04-20T21:10:38.120489Z","end":"2026-04-20T21:10:38.23927Z","steps":["trace[1678999077] 'agreement among raft nodes before linearized reading' (duration: 118.609024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:11:07.176726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.285625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-z76zw\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T21:11:07.176818Z","caller":"traceutil/trace.go:171","msg":"trace[1201912782] range","detail":"{range_begin:/registry/pods/openstack/keepalived-z76zw; range_end:; response_count:1; response_revision:8348; }","duration":"127.414487ms","start":"2026-04-20T21:11:07.049382Z","end":"2026-04-20T21:11:07.176796Z","steps":["trace[1201912782] 'range keys from in-memory index tree' (duration: 127.108651ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:11:14.118677Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6210} {"level":"info","ts":"2026-04-20T21:11:14.231395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6210,"took":"110.610663ms","hash":74444637,"current-db-size-bytes":58748928,"current-db-size":"59 MB","current-db-size-in-use-bytes":23244800,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-20T21:11:14.231495Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":74444637,"revision":6210,"compact-revision":3047} {"level":"info","ts":"2026-04-20T21:11:17.961444Z","caller":"traceutil/trace.go:171","msg":"trace[2110899018] transaction","detail":"{read_only:false; response_revision:8444; number_of_response:1; }","duration":"162.350274ms","start":"2026-04-20T21:11:17.799069Z","end":"2026-04-20T21:11:17.961419Z","steps":["trace[2110899018] 'process raft request' (duration: 154.954094ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:11:17.979406Z","caller":"traceutil/trace.go:171","msg":"trace[1208728725] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8445; }","duration":"179.495725ms","start":"2026-04-20T21:11:17.799717Z","end":"2026-04-20T21:11:17.979213Z","steps":["trace[1208728725] 'process raft request' (duration: 179.163898ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:11:19.068889Z","caller":"traceutil/trace.go:171","msg":"trace[1215743423] transaction","detail":"{read_only:false; response_revision:8455; number_of_response:1; }","duration":"340.717965ms","start":"2026-04-20T21:11:18.728101Z","end":"2026-04-20T21:11:19.068819Z","steps":["trace[1215743423] 'process raft request' (duration: 328.718656ms)","trace[1215743423] 'compare' (duration: 11.649152ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T21:11:19.069078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:11:18.728084Z","time spent":"340.89466ms","remote":"127.0.0.1:59756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T21:11:19.136801Z","caller":"traceutil/trace.go:171","msg":"trace[1319979226] linearizableReadLoop","detail":"{readStateIndex:8749; appliedIndex:8747; }","duration":"337.464094ms","start":"2026-04-20T21:11:18.799312Z","end":"2026-04-20T21:11:19.136776Z","steps":["trace[1319979226] 'read index received' (duration: 257.519174ms)","trace[1319979226] 'applied index is now lower than readState.Index' (duration: 79.94393ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T21:11:19.136941Z","caller":"traceutil/trace.go:171","msg":"trace[1569382635] transaction","detail":"{read_only:false; response_revision:8456; number_of_response:1; }","duration":"353.39943ms","start":"2026-04-20T21:11:18.783518Z","end":"2026-04-20T21:11:19.136917Z","steps":["trace[1569382635] 'process raft request' (duration: 353.127234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:11:19.137081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:11:18.783483Z","time spent":"353.502521ms","remote":"127.0.0.1:51158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T21:11:19.137337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.985736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-04-20T21:11:19.137445Z","caller":"traceutil/trace.go:171","msg":"trace[714478190] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8456; }","duration":"338.16482ms","start":"2026-04-20T21:11:18.799256Z","end":"2026-04-20T21:11:19.137421Z","steps":["trace[714478190] 'agreement among raft nodes before linearized reading' (duration: 337.842022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:11:19.137506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:11:18.799233Z","time spent":"338.259652ms","remote":"127.0.0.1:57496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5755,"request content":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" "} {"level":"warn","ts":"2026-04-20T21:11:19.138186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.871817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T21:11:19.138226Z","caller":"traceutil/trace.go:171","msg":"trace[980671713] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8456; }","duration":"144.960019ms","start":"2026-04-20T21:11:18.993254Z","end":"2026-04-20T21:11:19.138214Z","steps":["trace[980671713] 'agreement among raft nodes before linearized reading' (duration: 144.846216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:11:19.138422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.524426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-20T21:11:19.13853Z","caller":"traceutil/trace.go:171","msg":"trace[1740521576] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8456; }","duration":"124.69106ms","start":"2026-04-20T21:11:19.013812Z","end":"2026-04-20T21:11:19.138503Z","steps":["trace[1740521576] 'agreement among raft nodes before linearized reading' (duration: 124.270221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:11:19.138762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.803574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T21:11:19.138812Z","caller":"traceutil/trace.go:171","msg":"trace[1907332398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8456; }","duration":"241.874365ms","start":"2026-04-20T21:11:18.896922Z","end":"2026-04-20T21:11:19.138796Z","steps":["trace[1907332398] 'agreement among raft nodes before linearized reading' (duration: 241.071868ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:11:19.265585Z","caller":"traceutil/trace.go:171","msg":"trace[774113809] transaction","detail":"{read_only:false; response_revision:8457; number_of_response:1; }","duration":"122.399698ms","start":"2026-04-20T21:11:19.143157Z","end":"2026-04-20T21:11:19.265557Z","steps":["trace[774113809] 'process raft request' (duration: 122.247555ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:11:19.442343Z","caller":"traceutil/trace.go:171","msg":"trace[828335565] transaction","detail":"{read_only:false; response_revision:8458; number_of_response:1; }","duration":"292.208825ms","start":"2026-04-20T21:11:19.150108Z","end":"2026-04-20T21:11:19.442317Z","steps":["trace[828335565] 'process raft request' (duration: 218.919298ms)","trace[828335565] 'compare' (duration: 73.062012ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T21:11:19.442493Z","caller":"traceutil/trace.go:171","msg":"trace[1221986617] linearizableReadLoop","detail":"{readStateIndex:8751; appliedIndex:8749; }","duration":"227.391622ms","start":"2026-04-20T21:11:19.215083Z","end":"2026-04-20T21:11:19.442475Z","steps":["trace[1221986617] 'read index received' (duration: 50.35797ms)","trace[1221986617] 'applied index is now lower than readState.Index' (duration: 177.032532ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T21:11:19.442742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.637168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T21:11:19.442806Z","caller":"traceutil/trace.go:171","msg":"trace[1983664436] transaction","detail":"{read_only:false; response_revision:8459; number_of_response:1; }","duration":"200.589542ms","start":"2026-04-20T21:11:19.242184Z","end":"2026-04-20T21:11:19.442774Z","steps":["trace[1983664436] 'process raft request' (duration: 200.05526ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:11:19.44286Z","caller":"traceutil/trace.go:171","msg":"trace[1016746057] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8459; }","duration":"227.795682ms","start":"2026-04-20T21:11:19.215044Z","end":"2026-04-20T21:11:19.442839Z","steps":["trace[1016746057] 'agreement among raft nodes before linearized reading' (duration: 227.574567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:11:19.442967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.114115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-z76zw\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T21:11:19.44314Z","caller":"traceutil/trace.go:171","msg":"trace[439816333] range","detail":"{range_begin:/registry/pods/openstack/keepalived-z76zw; range_end:; response_count:1; response_revision:8459; }","duration":"196.422582ms","start":"2026-04-20T21:11:19.246665Z","end":"2026-04-20T21:11:19.443088Z","steps":["trace[439816333] 'agreement among raft nodes before linearized reading' (duration: 195.970672ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:11:20.640259Z","caller":"traceutil/trace.go:171","msg":"trace[1684876784] transaction","detail":"{read_only:false; response_revision:8463; number_of_response:1; }","duration":"260.292354ms","start":"2026-04-20T21:11:20.379941Z","end":"2026-04-20T21:11:20.640233Z","steps":["trace[1684876784] 'process raft request' (duration: 260.136781ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:11:20.671019Z","caller":"traceutil/trace.go:171","msg":"trace[1326984406] transaction","detail":"{read_only:false; response_revision:8464; number_of_response:1; }","duration":"266.850586ms","start":"2026-04-20T21:11:20.404147Z","end":"2026-04-20T21:11:20.670998Z","steps":["trace[1326984406] 'process raft request' (duration: 266.704893ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:11:20.671244Z","caller":"traceutil/trace.go:171","msg":"trace[1048094369] linearizableReadLoop","detail":"{readStateIndex:8758; appliedIndex:8755; }","duration":"141.889402ms","start":"2026-04-20T21:11:20.529334Z","end":"2026-04-20T21:11:20.671224Z","steps":["trace[1048094369] 'read index received' (duration: 110.770928ms)","trace[1048094369] 'applied index is now lower than readState.Index' (duration: 31.116474ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T21:11:20.671427Z","caller":"traceutil/trace.go:171","msg":"trace[790481820] transaction","detail":"{read_only:false; response_revision:8465; number_of_response:1; }","duration":"262.783659ms","start":"2026-04-20T21:11:20.408624Z","end":"2026-04-20T21:11:20.671407Z","steps":["trace[790481820] 'process raft request' (duration: 262.334689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:11:20.671461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.977226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-20T21:11:20.671493Z","caller":"traceutil/trace.go:171","msg":"trace[2051991446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8465; }","duration":"108.052918ms","start":"2026-04-20T21:11:20.563432Z","end":"2026-04-20T21:11:20.671484Z","steps":["trace[2051991446] 'agreement among raft nodes before linearized reading' (duration: 107.944966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:11:20.671499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.153117ms","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-04-20T21:11:20.671546Z","caller":"traceutil/trace.go:171","msg":"trace[1122409703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8465; }","duration":"142.250479ms","start":"2026-04-20T21:11:20.529283Z","end":"2026-04-20T21:11:20.671533Z","steps":["trace[1122409703] 'agreement among raft nodes before linearized reading' (duration: 142.067945ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:12:07.534504Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002428.wal"} {"level":"info","ts":"2026-04-20T21:13:42.537527Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T21:13:42.543223Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T21:13:42.543347Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T21:16:14.12564Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8414} {"level":"info","ts":"2026-04-20T21:16:14.207415Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8414,"took":"79.491678ms","hash":191688891,"current-db-size-bytes":58748928,"current-db-size":"59 MB","current-db-size-in-use-bytes":24449024,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-20T21:16:14.207484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":191688891,"revision":8414,"compact-revision":6210} {"level":"info","ts":"2026-04-20T21:21:14.131479Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10730} {"level":"info","ts":"2026-04-20T21:21:14.205293Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10730,"took":"71.987774ms","hash":3561548356,"current-db-size-bytes":58748928,"current-db-size":"59 MB","current-db-size-in-use-bytes":20328448,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-20T21:21:14.205368Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3561548356,"revision":10730,"compact-revision":8414}