{"level":"warn","ts":"2026-08-07T20:46:21.67639Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-07T20:46:21.676487Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-08-07T20:46:21.676558Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-07T20:46:21.676573Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-08-07T20:46:21.676592Z","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-08-07T20:46:21.677249Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-08-07T20:46:21.67732Z","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":8,"max-cpu-available":8,"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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-08-07T20:46:21.681495Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.964411ms"} {"level":"info","ts":"2026-08-07T20:46:21.687302Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-08-07T20:46:21.687377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-08-07T20:46:21.687426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-08-07T20:46:21.68744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-07T20:46:21.687449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-08-07T20:46:21.687486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-08-07T20:46:21.69521Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-07T20:46:21.696842Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-07T20:46:21.698767Z","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-08-07T20:46:21.700706Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-07T20:46:21.700863Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-07T20:46:21.701188Z","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-08-07T20:46:21.701496Z","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-08-07T20:46:21.705625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-08-07T20:46:21.705701Z","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-08-07T20:46:21.705942Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-08-07T20:46:21.710376Z","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-08-07T20:46:21.710484Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-08-07T20:46:21.710561Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-08-07T20:46:21.710635Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-07T20:46:21.710997Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-07T20:46:22.388573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-08-07T20:46:22.388666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-08-07T20:46:22.388719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-08-07T20:46:22.388748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-08-07T20:46:22.388765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-08-07T20:46:22.388782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-08-07T20:46:22.388802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-08-07T20:46:22.391594Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T20:46:22.391764Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-07T20:46:22.391788Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-08-07T20:46:22.391846Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-07T20:46:22.392181Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-07T20:46:22.392208Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-07T20:46:22.392668Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T20:46:22.392762Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T20:46:22.392796Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T20:46:22.394943Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-07T20:46:22.396076Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-08-07T20:46:58.564222Z","caller":"traceutil/trace.go:171","msg":"trace[961933361] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"110.872292ms","start":"2026-08-07T20:46:58.453302Z","end":"2026-08-07T20:46:58.564174Z","steps":["trace[961933361] 'process raft request' (duration: 101.235208ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:47:04.591768Z","caller":"traceutil/trace.go:171","msg":"trace[1276418838] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"168.086205ms","start":"2026-08-07T20:47:04.423653Z","end":"2026-08-07T20:47:04.591739Z","steps":["trace[1276418838] 'read index received' (duration: 167.192707ms)","trace[1276418838] 'applied index is now lower than readState.Index' (duration: 892.558µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:47:04.591879Z","caller":"traceutil/trace.go:171","msg":"trace[1979177081] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"177.451243ms","start":"2026-08-07T20:47:04.414388Z","end":"2026-08-07T20:47:04.591839Z","steps":["trace[1979177081] 'process raft request' (duration: 176.676456ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:47:04.615534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.844571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-07T20:47:04.615657Z","caller":"traceutil/trace.go:171","msg":"trace[2092304453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"192.010912ms","start":"2026-08-07T20:47:04.423622Z","end":"2026-08-07T20:47:04.615633Z","steps":["trace[2092304453] 'agreement among raft nodes before linearized reading' (duration: 168.235916ms)","trace[2092304453] 'range keys from in-memory index tree' (duration: 23.473843ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:47:05.090196Z","caller":"traceutil/trace.go:171","msg":"trace[751992681] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"246.342054ms","start":"2026-08-07T20:47:04.843831Z","end":"2026-08-07T20:47:05.090173Z","steps":["trace[751992681] 'process raft request' (duration: 246.228123ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:47:05.09021Z","caller":"traceutil/trace.go:171","msg":"trace[1389770158] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"435.776175ms","start":"2026-08-07T20:47:04.654406Z","end":"2026-08-07T20:47:05.090182Z","steps":["trace[1389770158] 'process raft request' (duration: 390.707497ms)","trace[1389770158] 'compare' (duration: 44.622583ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T20:47:05.09099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T20:47:04.654388Z","time spent":"436.091227ms","remote":"127.0.0.1:58462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T20:47:18.708437Z","caller":"traceutil/trace.go:171","msg":"trace[838766960] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"165.223345ms","start":"2026-08-07T20:47:18.54316Z","end":"2026-08-07T20:47:18.708383Z","steps":["trace[838766960] 'process raft request' (duration: 146.214075ms)","trace[838766960] 'compare' (duration: 18.518216ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:48:34.945663Z","caller":"traceutil/trace.go:171","msg":"trace[1179082128] linearizableReadLoop","detail":"{readStateIndex:1906; appliedIndex:1905; }","duration":"139.516374ms","start":"2026-08-07T20:48:34.806117Z","end":"2026-08-07T20:48:34.945634Z","steps":["trace[1179082128] 'read index received' (duration: 139.249237ms)","trace[1179082128] 'applied index is now lower than readState.Index' (duration: 265.267µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:48:34.945803Z","caller":"traceutil/trace.go:171","msg":"trace[189738342] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"294.926955ms","start":"2026-08-07T20:48:34.650826Z","end":"2026-08-07T20:48:34.945753Z","steps":["trace[189738342] 'process raft request' (duration: 294.584166ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:48:34.992097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.959557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-07T20:48:34.996745Z","caller":"traceutil/trace.go:171","msg":"trace[1828188748] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1839; }","duration":"190.570355ms","start":"2026-08-07T20:48:34.806098Z","end":"2026-08-07T20:48:34.996669Z","steps":["trace[1828188748] 'agreement among raft nodes before linearized reading' (duration: 139.688849ms)","trace[1828188748] 'range keys from in-memory index tree' (duration: 46.129145ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T20:48:35.012635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.044311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-07T20:48:35.012701Z","caller":"traceutil/trace.go:171","msg":"trace[1214490823] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1840; }","duration":"171.183645ms","start":"2026-08-07T20:48:34.841501Z","end":"2026-08-07T20:48:35.012685Z","steps":["trace[1214490823] 'agreement among raft nodes before linearized reading' (duration: 170.949849ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:49:18.527988Z","caller":"traceutil/trace.go:171","msg":"trace[620801032] linearizableReadLoop","detail":"{readStateIndex:2205; appliedIndex:2204; }","duration":"107.433047ms","start":"2026-08-07T20:49:18.420528Z","end":"2026-08-07T20:49:18.527961Z","steps":["trace[620801032] 'read index received' (duration: 97.845704ms)","trace[620801032] 'applied index is now lower than readState.Index' (duration: 9.586203ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:49:18.528064Z","caller":"traceutil/trace.go:171","msg":"trace[1948772312] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"153.427221ms","start":"2026-08-07T20:49:18.374587Z","end":"2026-08-07T20:49:18.528014Z","steps":["trace[1948772312] 'process raft request' (duration: 143.853178ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:49:18.528183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.64681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T20:49:18.528251Z","caller":"traceutil/trace.go:171","msg":"trace[2016883476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2129; }","duration":"107.767972ms","start":"2026-08-07T20:49:18.420465Z","end":"2026-08-07T20:49:18.528233Z","steps":["trace[2016883476] 'agreement among raft nodes before linearized reading' (duration: 107.61673ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:50:57.028237Z","caller":"traceutil/trace.go:171","msg":"trace[962225051] transaction","detail":"{read_only:false; response_revision:2769; number_of_response:1; }","duration":"171.677388ms","start":"2026-08-07T20:50:56.856519Z","end":"2026-08-07T20:50:57.028197Z","steps":["trace[962225051] 'process raft request' (duration: 171.441095ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:50:57.035225Z","caller":"traceutil/trace.go:171","msg":"trace[1298713417] transaction","detail":"{read_only:false; response_revision:2770; number_of_response:1; }","duration":"177.574618ms","start":"2026-08-07T20:50:56.857612Z","end":"2026-08-07T20:50:57.035186Z","steps":["trace[1298713417] 'process raft request' (duration: 177.149673ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:50:57.427804Z","caller":"traceutil/trace.go:171","msg":"trace[451968968] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"106.90225ms","start":"2026-08-07T20:50:57.32088Z","end":"2026-08-07T20:50:57.427782Z","steps":["trace[451968968] 'process raft request' (duration: 106.626837ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:54:44.007873Z","caller":"traceutil/trace.go:171","msg":"trace[1921285515] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"101.97615ms","start":"2026-08-07T20:54:43.905863Z","end":"2026-08-07T20:54:44.007839Z","steps":["trace[1921285515] 'process raft request' (duration: 12.447961ms)","trace[1921285515] 'compare' (duration: 89.402637ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:54:49.707904Z","caller":"traceutil/trace.go:171","msg":"trace[198998859] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"110.806103ms","start":"2026-08-07T20:54:49.597006Z","end":"2026-08-07T20:54:49.707812Z","steps":["trace[198998859] 'process raft request' (duration: 108.486595ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:54:49.913979Z","caller":"traceutil/trace.go:171","msg":"trace[232011346] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"198.25889ms","start":"2026-08-07T20:54:49.715689Z","end":"2026-08-07T20:54:49.913948Z","steps":["trace[232011346] 'process raft request' (duration: 197.936875ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:54:49.91417Z","caller":"traceutil/trace.go:171","msg":"trace[1382975416] transaction","detail":"{read_only:false; response_revision:4736; number_of_response:1; }","duration":"196.104157ms","start":"2026-08-07T20:54:49.718037Z","end":"2026-08-07T20:54:49.914141Z","steps":["trace[1382975416] 'process raft request' (duration: 195.861172ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:54:49.914198Z","caller":"traceutil/trace.go:171","msg":"trace[1604878324] linearizableReadLoop","detail":"{readStateIndex:4913; appliedIndex:4907; }","duration":"179.284127ms","start":"2026-08-07T20:54:49.734886Z","end":"2026-08-07T20:54:49.91417Z","steps":["trace[1604878324] 'read index received' (duration: 45.504508ms)","trace[1604878324] 'applied index is now lower than readState.Index' (duration: 133.778289ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:54:49.914547Z","caller":"traceutil/trace.go:171","msg":"trace[2134301775] transaction","detail":"{read_only:false; response_revision:4737; number_of_response:1; }","duration":"190.248593ms","start":"2026-08-07T20:54:49.724282Z","end":"2026-08-07T20:54:49.91453Z","steps":["trace[2134301775] 'process raft request' (duration: 189.827427ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:54:49.91459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.683123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T20:54:49.914748Z","caller":"traceutil/trace.go:171","msg":"trace[1775701607] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:4737; }","duration":"179.896717ms","start":"2026-08-07T20:54:49.734826Z","end":"2026-08-07T20:54:49.914723Z","steps":["trace[1775701607] 'agreement among raft nodes before linearized reading' (duration: 179.698824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:54:49.943926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.117452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-08-07T20:54:49.944014Z","caller":"traceutil/trace.go:171","msg":"trace[51217660] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4739; }","duration":"202.218094ms","start":"2026-08-07T20:54:49.741775Z","end":"2026-08-07T20:54:49.943993Z","steps":["trace[51217660] 'agreement among raft nodes before linearized reading' (duration: 201.97487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:54:49.94819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.678584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-07T20:54:49.948353Z","caller":"traceutil/trace.go:171","msg":"trace[631401479] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4739; }","duration":"124.848437ms","start":"2026-08-07T20:54:49.823427Z","end":"2026-08-07T20:54:49.948275Z","steps":["trace[631401479] 'agreement among raft nodes before linearized reading' (duration: 120.763321ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:54:50.189981Z","caller":"traceutil/trace.go:171","msg":"trace[857905678] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"119.221304ms","start":"2026-08-07T20:54:50.070732Z","end":"2026-08-07T20:54:50.189953Z","steps":["trace[857905678] 'process raft request' (duration: 94.814324ms)","trace[857905678] 'compare' (duration: 23.909512ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:54:50.190246Z","caller":"traceutil/trace.go:171","msg":"trace[996004699] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"100.726808ms","start":"2026-08-07T20:54:50.089491Z","end":"2026-08-07T20:54:50.190218Z","steps":["trace[996004699] 'process raft request' (duration: 100.331542ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:54:50.190565Z","caller":"traceutil/trace.go:171","msg":"trace[1020226376] linearizableReadLoop","detail":"{readStateIndex:4929; appliedIndex:4928; }","duration":"115.594475ms","start":"2026-08-07T20:54:50.074962Z","end":"2026-08-07T20:54:50.190556Z","steps":["trace[1020226376] 'read index received' (duration: 48.561585ms)","trace[1020226376] 'applied index is now lower than readState.Index' (duration: 67.03196ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T20:54:50.190755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.770938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-08-07T20:54:50.190784Z","caller":"traceutil/trace.go:171","msg":"trace[1772754613] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4755; }","duration":"115.845849ms","start":"2026-08-07T20:54:50.074928Z","end":"2026-08-07T20:54:50.190774Z","steps":["trace[1772754613] 'agreement among raft nodes before linearized reading' (duration: 115.659396ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:54:50.456701Z","caller":"traceutil/trace.go:171","msg":"trace[178179302] linearizableReadLoop","detail":"{readStateIndex:4940; appliedIndex:4938; }","duration":"103.425241ms","start":"2026-08-07T20:54:50.353249Z","end":"2026-08-07T20:54:50.456674Z","steps":["trace[178179302] 'read index received' (duration: 96.570972ms)","trace[178179302] 'applied index is now lower than readState.Index' (duration: 6.852939ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:54:50.457009Z","caller":"traceutil/trace.go:171","msg":"trace[1640239554] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"104.665421ms","start":"2026-08-07T20:54:50.352304Z","end":"2026-08-07T20:54:50.456969Z","steps":["trace[1640239554] 'process raft request' (duration: 104.299185ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:54:50.457055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.559513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-08-07T20:54:50.457102Z","caller":"traceutil/trace.go:171","msg":"trace[280382537] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4764; }","duration":"103.656945ms","start":"2026-08-07T20:54:50.353433Z","end":"2026-08-07T20:54:50.45709Z","steps":["trace[280382537] 'agreement among raft nodes before linearized reading' (duration: 103.411941ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:54:50.457485Z","caller":"traceutil/trace.go:171","msg":"trace[310549621] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"106.233726ms","start":"2026-08-07T20:54:50.351232Z","end":"2026-08-07T20:54:50.457466Z","steps":["trace[310549621] 'process raft request' (duration: 98.568404ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:54:50.458232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.962446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/openstack/rabbitmq-keystone-peer-discovery\" ","response":"range_response_count:1 size:814"} {"level":"info","ts":"2026-08-07T20:54:50.458307Z","caller":"traceutil/trace.go:171","msg":"trace[2119723187] range","detail":"{range_begin:/registry/roles/openstack/rabbitmq-keystone-peer-discovery; range_end:; response_count:1; response_revision:4764; }","duration":"105.067577ms","start":"2026-08-07T20:54:50.353226Z","end":"2026-08-07T20:54:50.458293Z","steps":["trace[2119723187] 'agreement among raft nodes before linearized reading' (duration: 103.606814ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:55:01.517249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.132523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-07T20:55:01.518595Z","caller":"traceutil/trace.go:171","msg":"trace[1904772814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4961; }","duration":"260.506534ms","start":"2026-08-07T20:55:01.258048Z","end":"2026-08-07T20:55:01.518554Z","steps":["trace[1904772814] 'range keys from in-memory index tree' (duration: 258.910638ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:56:22.419011Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2904} {"level":"info","ts":"2026-08-07T20:56:22.506249Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2904,"took":"85.744695ms","hash":3617389260,"current-db-size-bytes":54173696,"current-db-size":"54 MB","current-db-size-in-use-bytes":29151232,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-07T20:56:22.506492Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3617389260,"revision":2904,"compact-revision":-1} {"level":"warn","ts":"2026-08-07T20:58:59.55102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.054968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T20:58:59.551191Z","caller":"traceutil/trace.go:171","msg":"trace[1092342605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6701; }","duration":"126.26376ms","start":"2026-08-07T20:58:59.424906Z","end":"2026-08-07T20:58:59.551169Z","steps":["trace[1092342605] 'range keys from in-memory index tree' (duration: 125.975567ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:01:22.424317Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5597} {"level":"info","ts":"2026-08-07T21:01:22.50367Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5597,"took":"77.816696ms","hash":1797744818,"current-db-size-bytes":54173696,"current-db-size":"54 MB","current-db-size-in-use-bytes":18350080,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-07T21:01:22.503733Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1797744818,"revision":5597,"compact-revision":2904}