{"level":"warn","ts":"2026-07-15T04:49:46.702156Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T04:49:46.70224Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-07-15T04:49:46.702302Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T04:49:46.702315Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-07-15T04:49:46.70233Z","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-07-15T04:49:46.702986Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-07-15T04:49:46.703068Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-07-15T04:49:46.707775Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.504739ms"} {"level":"info","ts":"2026-07-15T04:49:46.7168Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-07-15T04:49:46.716912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-07-15T04:49:46.716941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-07-15T04:49:46.716951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-15T04:49:46.717004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-07-15T04:49:46.717052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-07-15T04:49:46.723192Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-15T04:49:46.729Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-15T04:49:46.730138Z","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-07-15T04:49:46.733878Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-15T04:49:46.734065Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-15T04:49:46.73492Z","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-07-15T04:49:46.73502Z","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-07-15T04:49:46.735035Z","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-07-15T04:49:46.735743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-07-15T04:49:46.735953Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-07-15T04:49:46.739151Z","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-07-15T04:49:46.73938Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-07-15T04:49:46.739477Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-07-15T04:49:46.739479Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-15T04:49:46.739516Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-15T04:49:47.717356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-07-15T04:49:47.717421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-15T04:49:47.717459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-07-15T04:49:47.717479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-07-15T04:49:47.71749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-07-15T04:49:47.717506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-07-15T04:49:47.71752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-07-15T04:49:47.718431Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-07-15T04:49:47.719043Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T04:49:47.719116Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T04:49:47.719309Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:49:47.719333Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-15T04:49:47.719479Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-15T04:49:47.720486Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:49:47.720666Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:49:47.721138Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:49:47.724199Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-07-15T04:49:47.725565Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-15T04:50:07.723125Z","caller":"traceutil/trace.go:171","msg":"trace[1042440704] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:399; }","duration":"329.273032ms","start":"2026-07-15T04:50:07.393825Z","end":"2026-07-15T04:50:07.723098Z","steps":["trace[1042440704] 'read index received' (duration: 329.058051ms)","trace[1042440704] 'applied index is now lower than readState.Index' (duration: 214.141µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:50:07.723534Z","caller":"traceutil/trace.go:171","msg":"trace[1372903989] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"331.041044ms","start":"2026-07-15T04:50:07.392475Z","end":"2026-07-15T04:50:07.723516Z","steps":["trace[1372903989] 'process raft request' (duration: 330.47218ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:50:07.724211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:50:07.392456Z","time spent":"331.114925ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:50:07.724381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.549701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-15T04:50:07.724498Z","caller":"traceutil/trace.go:171","msg":"trace[48434062] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:384; }","duration":"330.636572ms","start":"2026-07-15T04:50:07.393792Z","end":"2026-07-15T04:50:07.724428Z","steps":["trace[48434062] 'agreement among raft nodes before linearized reading' (duration: 330.551641ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:50:07.724529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:50:07.393781Z","time spent":"330.740532ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-15T04:50:07.724617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.548067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:50:07.724648Z","caller":"traceutil/trace.go:171","msg":"trace[651995838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:384; }","duration":"267.601747ms","start":"2026-07-15T04:50:07.457038Z","end":"2026-07-15T04:50:07.72464Z","steps":["trace[651995838] 'agreement among raft nodes before linearized reading' (duration: 267.561117ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:50:29.767826Z","caller":"traceutil/trace.go:171","msg":"trace[1542941075] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"161.176818ms","start":"2026-07-15T04:50:29.606628Z","end":"2026-07-15T04:50:29.767805Z","steps":["trace[1542941075] 'process raft request' (duration: 160.637065ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:50:30.466447Z","caller":"traceutil/trace.go:171","msg":"trace[1239515143] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"434.915027ms","start":"2026-07-15T04:50:30.031507Z","end":"2026-07-15T04:50:30.466422Z","steps":["trace[1239515143] 'process raft request' (duration: 395.032202ms)","trace[1239515143] 'compare' (duration: 39.498601ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:50:30.46659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:50:30.031473Z","time spent":"435.040838ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:50:30.468925Z","caller":"traceutil/trace.go:171","msg":"trace[1662688355] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"145.313592ms","start":"2026-07-15T04:50:30.323575Z","end":"2026-07-15T04:50:30.468888Z","steps":["trace[1662688355] 'process raft request' (duration: 144.647846ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:52:00.519817Z","caller":"traceutil/trace.go:171","msg":"trace[1983025181] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"206.539158ms","start":"2026-07-15T04:52:00.313238Z","end":"2026-07-15T04:52:00.519777Z","steps":["trace[1983025181] 'process raft request' (duration: 206.257813ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:52:00.779672Z","caller":"traceutil/trace.go:171","msg":"trace[1461131017] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"100.831947ms","start":"2026-07-15T04:52:00.678799Z","end":"2026-07-15T04:52:00.779631Z","steps":["trace[1461131017] 'process raft request' (duration: 89.193213ms)","trace[1461131017] 'compare' (duration: 11.38084ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:52:36.763479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.519061ms","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-07-15T04:52:36.763624Z","caller":"traceutil/trace.go:171","msg":"trace[1819821861] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2069; }","duration":"292.652223ms","start":"2026-07-15T04:52:36.470902Z","end":"2026-07-15T04:52:36.763554Z","steps":["trace[1819821861] 'range keys from in-memory index tree' (duration: 292.342049ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:52:36.779708Z","caller":"traceutil/trace.go:171","msg":"trace[1633560911] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"105.274526ms","start":"2026-07-15T04:52:36.674398Z","end":"2026-07-15T04:52:36.779673Z","steps":["trace[1633560911] 'process raft request' (duration: 105.087034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:52:37.096284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.421463ms","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-07-15T04:52:37.096729Z","caller":"traceutil/trace.go:171","msg":"trace[1395223472] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2072; }","duration":"105.91072ms","start":"2026-07-15T04:52:36.990783Z","end":"2026-07-15T04:52:37.096693Z","steps":["trace[1395223472] 'range keys from in-memory index tree' (duration: 105.111468ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:54:13.81306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.821456ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:54:13.813407Z","caller":"traceutil/trace.go:171","msg":"trace[1938544069] linearizableReadLoop","detail":"{readStateIndex:2799; appliedIndex:2798; }","duration":"128.202343ms","start":"2026-07-15T04:54:13.685177Z","end":"2026-07-15T04:54:13.81338Z","steps":["trace[1938544069] 'read index received' (duration: 21.503528ms)","trace[1938544069] 'applied index is now lower than readState.Index' (duration: 106.696795ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:54:13.813456Z","caller":"traceutil/trace.go:171","msg":"trace[678171145] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"220.569116ms","start":"2026-07-15T04:54:13.592835Z","end":"2026-07-15T04:54:13.813404Z","steps":["trace[678171145] 'process raft request' (duration: 113.85811ms)","trace[678171145] 'compare' (duration: 105.477833ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:54:13.813789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.564417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-07-15T04:54:13.813945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.705076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-15T04:54:13.814082Z","caller":"traceutil/trace.go:171","msg":"trace[1925227341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2701; }","duration":"107.927359ms","start":"2026-07-15T04:54:13.706125Z","end":"2026-07-15T04:54:13.814053Z","steps":["trace[1925227341] 'agreement among raft nodes before linearized reading' (duration: 107.524844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:54:13.814142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.708178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-15T04:54:13.814203Z","caller":"traceutil/trace.go:171","msg":"trace[1252047089] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2701; }","duration":"109.82645ms","start":"2026-07-15T04:54:13.704362Z","end":"2026-07-15T04:54:13.814188Z","steps":["trace[1252047089] 'agreement among raft nodes before linearized reading' (duration: 109.614797ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:54:13.814784Z","caller":"traceutil/trace.go:171","msg":"trace[1856890959] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2701; }","duration":"128.747789ms","start":"2026-07-15T04:54:13.685123Z","end":"2026-07-15T04:54:13.813871Z","steps":["trace[1856890959] 'agreement among raft nodes before linearized reading' (duration: 128.387165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:53.029481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.956047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:57:53.029585Z","caller":"traceutil/trace.go:171","msg":"trace[1940763155] linearizableReadLoop","detail":"{readStateIndex:4748; appliedIndex:4746; }","duration":"259.429224ms","start":"2026-07-15T04:57:52.77014Z","end":"2026-07-15T04:57:53.02957Z","steps":["trace[1940763155] 'read index received' (duration: 79.441407ms)","trace[1940763155] 'applied index is now lower than readState.Index' (duration: 179.986567ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:57:53.029887Z","caller":"traceutil/trace.go:171","msg":"trace[1702021828] transaction","detail":"{read_only:false; response_revision:4578; number_of_response:1; }","duration":"263.211219ms","start":"2026-07-15T04:57:52.76666Z","end":"2026-07-15T04:57:53.029872Z","steps":["trace[1702021828] 'process raft request' (duration: 145.790046ms)","trace[1702021828] 'compare' (duration: 116.864335ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:57:53.030209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.031503ms","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-07-15T04:57:53.031006Z","caller":"traceutil/trace.go:171","msg":"trace[1008494112] 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:4578; }","duration":"260.855695ms","start":"2026-07-15T04:57:52.770126Z","end":"2026-07-15T04:57:53.030981Z","steps":["trace[1008494112] 'agreement among raft nodes before linearized reading' (duration: 259.89159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:53.061699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.499559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-15T04:57:53.061802Z","caller":"traceutil/trace.go:171","msg":"trace[1545034847] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4579; }","duration":"169.671511ms","start":"2026-07-15T04:57:52.892109Z","end":"2026-07-15T04:57:53.061781Z","steps":["trace[1545034847] 'agreement among raft nodes before linearized reading' (duration: 169.370167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:53.061882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.809102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-15T04:57:53.061991Z","caller":"traceutil/trace.go:171","msg":"trace[1413296227] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:4579; }","duration":"263.062925ms","start":"2026-07-15T04:57:52.798911Z","end":"2026-07-15T04:57:53.061973Z","steps":["trace[1413296227] 'agreement among raft nodes before linearized reading' (duration: 262.782501ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:05.35832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.849649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-15T04:58:05.358421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.660396ms","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":"warn","ts":"2026-07-15T04:58:05.358451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.134333ms","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-07-15T04:58:05.358477Z","caller":"traceutil/trace.go:171","msg":"trace[76796482] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4800; }","duration":"193.726427ms","start":"2026-07-15T04:58:05.164733Z","end":"2026-07-15T04:58:05.35846Z","steps":["trace[76796482] 'range keys from in-memory index tree' (duration: 193.546655ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:05.358491Z","caller":"traceutil/trace.go:171","msg":"trace[432597068] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4800; }","duration":"198.216403ms","start":"2026-07-15T04:58:05.160263Z","end":"2026-07-15T04:58:05.358479Z","steps":["trace[432597068] 'range keys from in-memory index tree' (duration: 198.0004ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:05.358507Z","caller":"traceutil/trace.go:171","msg":"trace[1212179694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4800; }","duration":"196.093523ms","start":"2026-07-15T04:58:05.162402Z","end":"2026-07-15T04:58:05.358495Z","steps":["trace[1212179694] 'range keys from in-memory index tree' (duration: 195.648106ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:05.358629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.299255ms","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-07-15T04:58:05.358665Z","caller":"traceutil/trace.go:171","msg":"trace[1590725721] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4800; }","duration":"196.358266ms","start":"2026-07-15T04:58:05.162295Z","end":"2026-07-15T04:58:05.358654Z","steps":["trace[1590725721] 'range keys from in-memory index tree' (duration: 196.199344ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:05.379787Z","caller":"traceutil/trace.go:171","msg":"trace[1268373516] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"178.598908ms","start":"2026-07-15T04:58:05.201168Z","end":"2026-07-15T04:58:05.379767Z","steps":["trace[1268373516] 'process raft request' (duration: 178.476265ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:05.717174Z","caller":"traceutil/trace.go:171","msg":"trace[1334111008] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"354.974143ms","start":"2026-07-15T04:58:05.362168Z","end":"2026-07-15T04:58:05.717142Z","steps":["trace[1334111008] 'process raft request' (duration: 354.668569ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:05.717319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:05.362158Z","time spent":"355.086725ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:58:05.716939Z","caller":"traceutil/trace.go:171","msg":"trace[556522530] transaction","detail":"{read_only:false; response_revision:4802; number_of_response:1; }","duration":"354.915982ms","start":"2026-07-15T04:58:05.362Z","end":"2026-07-15T04:58:05.716916Z","steps":["trace[556522530] 'process raft request' (duration: 354.595717ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:05.717391Z","caller":"traceutil/trace.go:171","msg":"trace[200445513] transaction","detail":"{read_only:false; response_revision:4804; number_of_response:1; }","duration":"354.423044ms","start":"2026-07-15T04:58:05.362951Z","end":"2026-07-15T04:58:05.717374Z","steps":["trace[200445513] 'process raft request' (duration: 354.0775ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:05.717271Z","caller":"traceutil/trace.go:171","msg":"trace[1792049543] transaction","detail":"{read_only:false; response_revision:4805; number_of_response:1; }","duration":"354.08065ms","start":"2026-07-15T04:58:05.363174Z","end":"2026-07-15T04:58:05.717254Z","steps":["trace[1792049543] 'process raft request' (duration: 353.941598ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:05.717512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:05.362937Z","time spent":"354.501035ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:58:05.717656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:05.363166Z","time spent":"354.276242ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:58:05.717697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:05.36198Z","time spent":"355.40471ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:58:05.911309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.023743ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:58:05.911405Z","caller":"traceutil/trace.go:171","msg":"trace[1872342781] transaction","detail":"{read_only:false; response_revision:4806; number_of_response:1; }","duration":"419.167569ms","start":"2026-07-15T04:58:05.492219Z","end":"2026-07-15T04:58:05.911386Z","steps":["trace[1872342781] 'process raft request' (duration: 304.983783ms)","trace[1872342781] 'compare' (duration: 113.855951ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:58:05.911481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:05.492196Z","time spent":"419.23906ms","remote":"127.0.0.1:48740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:58:06.032484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.310063ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-15T04:58:06.032765Z","caller":"traceutil/trace.go:171","msg":"trace[1546089114] linearizableReadLoop","detail":"{readStateIndex:4982; appliedIndex:4981; }","duration":"170.040723ms","start":"2026-07-15T04:58:05.862694Z","end":"2026-07-15T04:58:06.032735Z","steps":["trace[1546089114] 'read index received' (duration: 52.515547ms)","trace[1546089114] 'applied index is now lower than readState.Index' (duration: 117.466155ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:58:06.032918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.205455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10394"} {"level":"info","ts":"2026-07-15T04:58:06.032973Z","caller":"traceutil/trace.go:171","msg":"trace[740191495] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4806; }","duration":"170.307456ms","start":"2026-07-15T04:58:05.862652Z","end":"2026-07-15T04:58:06.032959Z","steps":["trace[740191495] 'agreement among raft nodes before linearized reading' (duration: 170.123424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:06.033243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.413432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-07-15T04:58:06.033298Z","caller":"traceutil/trace.go:171","msg":"trace[1515864277] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4807; }","duration":"160.494313ms","start":"2026-07-15T04:58:05.872787Z","end":"2026-07-15T04:58:06.033281Z","steps":["trace[1515864277] 'agreement among raft nodes before linearized reading' (duration: 160.31522ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:06.033408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.596784ms","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-07-15T04:58:06.033441Z","caller":"traceutil/trace.go:171","msg":"trace[1190050628] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4807; }","duration":"127.650804ms","start":"2026-07-15T04:58:05.905781Z","end":"2026-07-15T04:58:06.033432Z","steps":["trace[1190050628] 'agreement among raft nodes before linearized reading' (duration: 127.562353ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:44.625215Z","caller":"traceutil/trace.go:171","msg":"trace[1724804847] transaction","detail":"{read_only:false; response_revision:5148; number_of_response:1; }","duration":"125.402649ms","start":"2026-07-15T04:58:44.499784Z","end":"2026-07-15T04:58:44.625187Z","steps":["trace[1724804847] 'process raft request' (duration: 37.166833ms)","trace[1724804847] 'compare' (duration: 88.013813ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:59:18.212594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.344938ms","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-07-15T04:59:18.212733Z","caller":"traceutil/trace.go:171","msg":"trace[1884538912] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5402; }","duration":"115.514541ms","start":"2026-07-15T04:59:18.097177Z","end":"2026-07-15T04:59:18.212692Z","steps":["trace[1884538912] 'range keys from in-memory index tree' (duration: 115.154096ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:47.749097Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2879} {"level":"info","ts":"2026-07-15T04:59:47.829503Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2879,"took":"78.977658ms","hash":1336971790,"current-db-size-bytes":52862976,"current-db-size":"53 MB","current-db-size-in-use-bytes":29589504,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-15T04:59:47.829584Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1336971790,"revision":2879,"compact-revision":-1} {"level":"info","ts":"2026-07-15T05:00:36.568857Z","caller":"traceutil/trace.go:171","msg":"trace[476615964] transaction","detail":"{read_only:false; response_revision:5851; number_of_response:1; }","duration":"100.38556ms","start":"2026-07-15T05:00:36.468448Z","end":"2026-07-15T05:00:36.568834Z","steps":["trace[476615964] 'process raft request' (duration: 100.285889ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:00:36.595225Z","caller":"traceutil/trace.go:171","msg":"trace[485396113] transaction","detail":"{read_only:false; response_revision:5852; number_of_response:1; }","duration":"108.42357ms","start":"2026-07-15T05:00:36.486774Z","end":"2026-07-15T05:00:36.595197Z","steps":["trace[485396113] 'process raft request' (duration: 108.223018ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:01:54.994698Z","caller":"traceutil/trace.go:171","msg":"trace[1632975581] transaction","detail":"{read_only:false; response_revision:6503; number_of_response:1; }","duration":"151.352308ms","start":"2026-07-15T05:01:54.843325Z","end":"2026-07-15T05:01:54.994677Z","steps":["trace[1632975581] 'process raft request' (duration: 151.191146ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:01:55.058682Z","caller":"traceutil/trace.go:171","msg":"trace[920241010] linearizableReadLoop","detail":"{readStateIndex:6738; appliedIndex:6735; }","duration":"133.817607ms","start":"2026-07-15T05:01:54.924837Z","end":"2026-07-15T05:01:55.058654Z","steps":["trace[920241010] 'read index received' (duration: 69.733797ms)","trace[920241010] 'applied index is now lower than readState.Index' (duration: 64.08272ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:01:55.058769Z","caller":"traceutil/trace.go:171","msg":"trace[1173042449] transaction","detail":"{read_only:false; response_revision:6505; number_of_response:1; }","duration":"181.658442ms","start":"2026-07-15T05:01:54.877104Z","end":"2026-07-15T05:01:55.058763Z","steps":["trace[1173042449] 'process raft request' (duration: 181.518421ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:01:55.058926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.07089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-15T05:01:55.058949Z","caller":"traceutil/trace.go:171","msg":"trace[670742119] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6505; }","duration":"134.154431ms","start":"2026-07-15T05:01:54.924789Z","end":"2026-07-15T05:01:55.058944Z","steps":["trace[670742119] 'agreement among raft nodes before linearized reading' (duration: 134.057519ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:01:55.058685Z","caller":"traceutil/trace.go:171","msg":"trace[649286995] transaction","detail":"{read_only:false; response_revision:6504; number_of_response:1; }","duration":"200.030003ms","start":"2026-07-15T05:01:54.85864Z","end":"2026-07-15T05:01:55.05867Z","steps":["trace[649286995] 'process raft request' (duration: 195.994885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:01:55.065842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.43915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-15T05:01:55.065904Z","caller":"traceutil/trace.go:171","msg":"trace[421642390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6506; }","duration":"136.54078ms","start":"2026-07-15T05:01:54.92935Z","end":"2026-07-15T05:01:55.065891Z","steps":["trace[421642390] 'agreement among raft nodes before linearized reading' (duration: 136.408799ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:04:47.752991Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5605} {"level":"info","ts":"2026-07-15T05:04:47.825977Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5605,"took":"71.799229ms","hash":2181007438,"current-db-size-bytes":52862976,"current-db-size":"53 MB","current-db-size-in-use-bytes":18190336,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-15T05:04:47.826044Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2181007438,"revision":5605,"compact-revision":2879}