{"level":"warn","ts":"2026-09-29T15:33:18.184236Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-29T15:33:18.184365Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.176:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.176:2380","--initial-cluster=instance=https://162.253.55.176:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.176:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.176: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-09-29T15:33:18.184461Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-29T15:33:18.184475Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-09-29T15:33:18.184512Z","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-09-29T15:33:18.185409Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"]} {"level":"info","ts":"2026-09-29T15:33:18.185506Z","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://162.253.55.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.176: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-09-29T15:33:18.19002Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.267226ms"} {"level":"info","ts":"2026-09-29T15:33:18.198818Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"590b810b00f00655","cluster-id":"dcc6923d0deac545"} {"level":"info","ts":"2026-09-29T15:33:18.198942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=()"} {"level":"info","ts":"2026-09-29T15:33:18.199007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 0"} {"level":"info","ts":"2026-09-29T15:33:18.199043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 590b810b00f00655 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-29T15:33:18.199086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 1"} {"level":"info","ts":"2026-09-29T15:33:18.199166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"warn","ts":"2026-09-29T15:33:18.206667Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-29T15:33:18.208102Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-29T15:33:18.209255Z","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-09-29T15:33:18.211509Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"590b810b00f00655","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-29T15:33:18.21184Z","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-09-29T15:33:18.211977Z","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-09-29T15:33:18.211995Z","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-09-29T15:33:18.212188Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"590b810b00f00655","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-29T15:33:18.214134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"info","ts":"2026-09-29T15:33:18.214584Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","added-peer-id":"590b810b00f00655","added-peer-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-09-29T15:33:18.217974Z","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-09-29T15:33:18.218233Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"590b810b00f00655","initial-advertise-peer-urls":["https://162.253.55.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-29T15:33:18.21827Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-29T15:33:18.218396Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-09-29T15:33:18.218414Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-09-29T15:33:19.09938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 is starting a new election at term 1"} {"level":"info","ts":"2026-09-29T15:33:19.099478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-29T15:33:19.099513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgPreVoteResp from 590b810b00f00655 at term 1"} {"level":"info","ts":"2026-09-29T15:33:19.099545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became candidate at term 2"} {"level":"info","ts":"2026-09-29T15:33:19.099554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgVoteResp from 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-09-29T15:33:19.099566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became leader at term 2"} {"level":"info","ts":"2026-09-29T15:33:19.099582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 590b810b00f00655 elected leader 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-09-29T15:33:19.10061Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"590b810b00f00655","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.176:2379]}","request-path":"/0/members/590b810b00f00655/attributes","cluster-id":"dcc6923d0deac545","publish-timeout":"7s"} {"level":"info","ts":"2026-09-29T15:33:19.10076Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:33:19.100968Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T15:33:19.101139Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-29T15:33:19.101246Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-29T15:33:19.10105Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T15:33:19.101535Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:33:19.1016Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:33:19.101619Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:33:19.105674Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-29T15:33:19.105727Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.176:2379"} {"level":"info","ts":"2026-09-29T15:34:03.887947Z","caller":"traceutil/trace.go:171","msg":"trace[1456343105] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"120.54462ms","start":"2026-09-29T15:34:03.767379Z","end":"2026-09-29T15:34:03.887924Z","steps":["trace[1456343105] 'process raft request' (duration: 120.371466ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:34:04.144363Z","caller":"traceutil/trace.go:171","msg":"trace[677914034] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"175.353057ms","start":"2026-09-29T15:34:03.968985Z","end":"2026-09-29T15:34:04.144338Z","steps":["trace[677914034] 'read index received' (duration: 174.569907ms)","trace[677914034] 'applied index is now lower than readState.Index' (duration: 781.91µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:34:04.144465Z","caller":"traceutil/trace.go:171","msg":"trace[833154975] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"261.768521ms","start":"2026-09-29T15:34:03.882687Z","end":"2026-09-29T15:34:04.144456Z","steps":["trace[833154975] 'process raft request' (duration: 261.135975ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:34:04.144658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.355521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-29T15:34:04.144826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.817569ms","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-09-29T15:34:04.144913Z","caller":"traceutil/trace.go:171","msg":"trace[1376398216] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"175.945403ms","start":"2026-09-29T15:34:03.968945Z","end":"2026-09-29T15:34:04.144891Z","steps":["trace[1376398216] 'agreement among raft nodes before linearized reading' (duration: 175.698996ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:34:04.144849Z","caller":"traceutil/trace.go:171","msg":"trace[2104627165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"102.557156ms","start":"2026-09-29T15:34:04.042265Z","end":"2026-09-29T15:34:04.144822Z","steps":["trace[2104627165] 'agreement among raft nodes before linearized reading' (duration: 102.283539ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:34:04.407743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.45815ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T15:34:04.407849Z","caller":"traceutil/trace.go:171","msg":"trace[238641991] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"258.332232ms","start":"2026-09-29T15:34:04.149499Z","end":"2026-09-29T15:34:04.407831Z","steps":["trace[238641991] 'process raft request' (duration: 24.827326ms)","trace[238641991] 'compare' (duration: 232.293586ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:34:04.679758Z","caller":"traceutil/trace.go:171","msg":"trace[1338392750] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"458.652362ms","start":"2026-09-29T15:34:04.221073Z","end":"2026-09-29T15:34:04.679726Z","steps":["trace[1338392750] 'process raft request' (duration: 390.973275ms)","trace[1338392750] 'compare' (duration: 67.216624ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:34:04.679887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:34:04.221043Z","time spent":"458.784695ms","remote":"127.0.0.1:52474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T15:34:20.631971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.199269ms","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-09-29T15:34:20.632118Z","caller":"traceutil/trace.go:171","msg":"trace[1396605644] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:794; }","duration":"133.396523ms","start":"2026-09-29T15:34:20.498689Z","end":"2026-09-29T15:34:20.632085Z","steps":["trace[1396605644] 'range keys from in-memory index tree' (duration: 132.908262ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:35:38.390456Z","caller":"traceutil/trace.go:171","msg":"trace[1760739788] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1930; }","duration":"114.783672ms","start":"2026-09-29T15:35:38.275641Z","end":"2026-09-29T15:35:38.390425Z","steps":["trace[1760739788] 'read index received' (duration: 114.500417ms)","trace[1760739788] 'applied index is now lower than readState.Index' (duration: 281.965µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:35:38.390528Z","caller":"traceutil/trace.go:171","msg":"trace[1225074348] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"142.077138ms","start":"2026-09-29T15:35:38.248425Z","end":"2026-09-29T15:35:38.390503Z","steps":["trace[1225074348] 'process raft request' (duration: 141.813934ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:35:38.390913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.156827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-29T15:35:38.39104Z","caller":"traceutil/trace.go:171","msg":"trace[1702847609] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1863; }","duration":"115.402432ms","start":"2026-09-29T15:35:38.275591Z","end":"2026-09-29T15:35:38.390993Z","steps":["trace[1702847609] 'agreement among raft nodes before linearized reading' (duration: 115.028955ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:35:38.825892Z","caller":"traceutil/trace.go:171","msg":"trace[1604655448] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1931; }","duration":"123.27185ms","start":"2026-09-29T15:35:38.70259Z","end":"2026-09-29T15:35:38.825862Z","steps":["trace[1604655448] 'read index received' (duration: 123.026377ms)","trace[1604655448] 'applied index is now lower than readState.Index' (duration: 244.173µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:35:38.826025Z","caller":"traceutil/trace.go:171","msg":"trace[954120982] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"193.529992ms","start":"2026-09-29T15:35:38.632425Z","end":"2026-09-29T15:35:38.825955Z","steps":["trace[954120982] 'process raft request' (duration: 193.267138ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:35:38.82615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.518164ms","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-09-29T15:35:38.82623Z","caller":"traceutil/trace.go:171","msg":"trace[1629684085] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1864; }","duration":"123.678127ms","start":"2026-09-29T15:35:38.702536Z","end":"2026-09-29T15:35:38.826214Z","steps":["trace[1629684085] 'agreement among raft nodes before linearized reading' (duration: 123.433513ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:35:46.503367Z","caller":"traceutil/trace.go:171","msg":"trace[113223378] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"182.097798ms","start":"2026-09-29T15:35:46.32124Z","end":"2026-09-29T15:35:46.503338Z","steps":["trace[113223378] 'process raft request' (duration: 181.829624ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:36:12.813887Z","caller":"traceutil/trace.go:171","msg":"trace[343919502] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"137.935182ms","start":"2026-09-29T15:36:12.675924Z","end":"2026-09-29T15:36:12.81386Z","steps":["trace[343919502] 'process raft request' (duration: 137.79984ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:36:12.995859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.489977ms","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-09-29T15:36:12.995977Z","caller":"traceutil/trace.go:171","msg":"trace[390322492] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2107; }","duration":"109.659689ms","start":"2026-09-29T15:36:12.886286Z","end":"2026-09-29T15:36:12.995945Z","steps":["trace[390322492] 'range keys from in-memory index tree' (duration: 109.261074ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:36:13.144643Z","caller":"traceutil/trace.go:171","msg":"trace[1245984976] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"118.591814ms","start":"2026-09-29T15:36:13.025994Z","end":"2026-09-29T15:36:13.144586Z","steps":["trace[1245984976] 'process raft request' (duration: 96.844691ms)","trace[1245984976] 'compare' (duration: 21.613421ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:36:13.376791Z","caller":"traceutil/trace.go:171","msg":"trace[2042631538] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"181.293262ms","start":"2026-09-29T15:36:13.195462Z","end":"2026-09-29T15:36:13.376755Z","steps":["trace[2042631538] 'process raft request' (duration: 179.547276ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:53.960646Z","caller":"traceutil/trace.go:171","msg":"trace[661760846] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"164.209738ms","start":"2026-09-29T15:37:53.796389Z","end":"2026-09-29T15:37:53.960599Z","steps":["trace[661760846] 'process raft request' (duration: 163.926118ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:38:27.296167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.647681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:38:27.296276Z","caller":"traceutil/trace.go:171","msg":"trace[781999773] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2929; }","duration":"133.816717ms","start":"2026-09-29T15:38:27.162436Z","end":"2026-09-29T15:38:27.296253Z","steps":["trace[781999773] 'count revisions from in-memory index tree' (duration: 133.478356ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:43.606541Z","caller":"traceutil/trace.go:171","msg":"trace[1714606187] linearizableReadLoop","detail":"{readStateIndex:5023; appliedIndex:5022; }","duration":"105.649056ms","start":"2026-09-29T15:42:43.500871Z","end":"2026-09-29T15:42:43.60652Z","steps":["trace[1714606187] 'read index received' (duration: 105.406962ms)","trace[1714606187] 'applied index is now lower than readState.Index' (duration: 241.064µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:42:43.606645Z","caller":"traceutil/trace.go:171","msg":"trace[469009100] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"106.888438ms","start":"2026-09-29T15:42:43.499725Z","end":"2026-09-29T15:42:43.606613Z","steps":["trace[469009100] 'process raft request' (duration: 106.652694ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:42:43.606739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.84603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-09-29T15:42:43.60677Z","caller":"traceutil/trace.go:171","msg":"trace[1080145726] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4841; }","duration":"105.923512ms","start":"2026-09-29T15:42:43.500839Z","end":"2026-09-29T15:42:43.606762Z","steps":["trace[1080145726] 'agreement among raft nodes before linearized reading' (duration: 105.760389ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:42:50.717497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.736187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-29T15:42:50.717633Z","caller":"traceutil/trace.go:171","msg":"trace[1241095696] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5000; }","duration":"152.230154ms","start":"2026-09-29T15:42:50.565372Z","end":"2026-09-29T15:42:50.717603Z","steps":["trace[1241095696] 'range keys from in-memory index tree' (duration: 150.545604ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.53886Z","caller":"traceutil/trace.go:171","msg":"trace[1087848347] linearizableReadLoop","detail":"{readStateIndex:5240; appliedIndex:5239; }","duration":"182.905932ms","start":"2026-09-29T15:42:57.35593Z","end":"2026-09-29T15:42:57.538836Z","steps":["trace[1087848347] 'read index received' (duration: 182.666857ms)","trace[1087848347] 'applied index is now lower than readState.Index' (duration: 238.005µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:42:57.538966Z","caller":"traceutil/trace.go:171","msg":"trace[1579158999] transaction","detail":"{read_only:false; response_revision:5051; number_of_response:1; }","duration":"230.83813ms","start":"2026-09-29T15:42:57.308095Z","end":"2026-09-29T15:42:57.538934Z","steps":["trace[1579158999] 'process raft request' (duration: 230.603435ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:42:57.539192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.234008ms","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-09-29T15:42:57.539264Z","caller":"traceutil/trace.go:171","msg":"trace[105101051] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5051; }","duration":"183.36738ms","start":"2026-09-29T15:42:57.355881Z","end":"2026-09-29T15:42:57.539248Z","steps":["trace[105101051] 'agreement among raft nodes before linearized reading' (duration: 183.106696ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:42:57.691623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.540409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-20d4d8bb-b02d-4c4a-a081-1ffe12ceda6f\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-09-29T15:42:57.691708Z","caller":"traceutil/trace.go:171","msg":"trace[430443979] range","detail":"{range_begin:/registry/persistentvolumes/pvc-20d4d8bb-b02d-4c4a-a081-1ffe12ceda6f; range_end:; response_count:1; response_revision:5051; }","duration":"142.670191ms","start":"2026-09-29T15:42:57.549019Z","end":"2026-09-29T15:42:57.69169Z","steps":["trace[430443979] 'range keys from in-memory index tree' (duration: 142.368966ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.691918Z","caller":"traceutil/trace.go:171","msg":"trace[1770662895] transaction","detail":"{read_only:false; response_revision:5052; number_of_response:1; }","duration":"142.757483ms","start":"2026-09-29T15:42:57.549125Z","end":"2026-09-29T15:42:57.691883Z","steps":["trace[1770662895] 'process raft request' (duration: 53.931623ms)","trace[1770662895] 'compare' (duration: 88.701338ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:42:57.781103Z","caller":"traceutil/trace.go:171","msg":"trace[342979415] transaction","detail":"{read_only:false; response_revision:5053; number_of_response:1; }","duration":"231.853057ms","start":"2026-09-29T15:42:57.549221Z","end":"2026-09-29T15:42:57.781074Z","steps":["trace[342979415] 'process raft request' (duration: 231.645754ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.781605Z","caller":"traceutil/trace.go:171","msg":"trace[957033262] linearizableReadLoop","detail":"{readStateIndex:5243; appliedIndex:5240; }","duration":"230.190938ms","start":"2026-09-29T15:42:57.55139Z","end":"2026-09-29T15:42:57.781581Z","steps":["trace[957033262] 'read index received' (duration: 51.740354ms)","trace[957033262] 'applied index is now lower than readState.Index' (duration: 178.449694ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:42:57.781672Z","caller":"traceutil/trace.go:171","msg":"trace[1158025868] transaction","detail":"{read_only:false; response_revision:5055; number_of_response:1; }","duration":"221.719807ms","start":"2026-09-29T15:42:57.559937Z","end":"2026-09-29T15:42:57.781657Z","steps":["trace[1158025868] 'process raft request' (duration: 221.542884ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:42:57.781836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.469472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1579"} {"level":"info","ts":"2026-09-29T15:42:57.781952Z","caller":"traceutil/trace.go:171","msg":"trace[1489228829] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5055; }","duration":"230.568694ms","start":"2026-09-29T15:42:57.5513Z","end":"2026-09-29T15:42:57.781868Z","steps":["trace[1489228829] 'agreement among raft nodes before linearized reading' (duration: 230.418581ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:42:57.781963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.32399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-09-29T15:42:57.781963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.477679ms","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-09-29T15:42:57.782009Z","caller":"traceutil/trace.go:171","msg":"trace[1371397694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5055; }","duration":"230.397551ms","start":"2026-09-29T15:42:57.551599Z","end":"2026-09-29T15:42:57.781996Z","steps":["trace[1371397694] 'agreement among raft nodes before linearized reading' (duration: 230.238068ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.782089Z","caller":"traceutil/trace.go:171","msg":"trace[1852474838] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:5055; }","duration":"163.627321ms","start":"2026-09-29T15:42:57.618441Z","end":"2026-09-29T15:42:57.782068Z","steps":["trace[1852474838] 'agreement among raft nodes before linearized reading' (duration: 163.426628ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:42:57.78212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.066309ms","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-09-29T15:42:57.782185Z","caller":"traceutil/trace.go:171","msg":"trace[766670817] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5055; }","duration":"224.162811ms","start":"2026-09-29T15:42:57.558005Z","end":"2026-09-29T15:42:57.782168Z","steps":["trace[766670817] 'agreement among raft nodes before linearized reading' (duration: 223.961048ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:42:57.78223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.785905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1579"} {"level":"info","ts":"2026-09-29T15:42:57.782267Z","caller":"traceutil/trace.go:171","msg":"trace[2110540079] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5055; }","duration":"227.838556ms","start":"2026-09-29T15:42:57.554416Z","end":"2026-09-29T15:42:57.782255Z","steps":["trace[2110540079] 'agreement among raft nodes before linearized reading' (duration: 227.750814ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.782748Z","caller":"traceutil/trace.go:171","msg":"trace[1229329962] transaction","detail":"{read_only:false; response_revision:5054; number_of_response:1; }","duration":"232.353616ms","start":"2026-09-29T15:42:57.549226Z","end":"2026-09-29T15:42:57.78158Z","steps":["trace[1229329962] 'process raft request' (duration: 231.795026ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.891265Z","caller":"traceutil/trace.go:171","msg":"trace[1961746607] transaction","detail":"{read_only:false; response_revision:5057; number_of_response:1; }","duration":"101.361871ms","start":"2026-09-29T15:42:57.789871Z","end":"2026-09-29T15:42:57.891232Z","steps":["trace[1961746607] 'process raft request' (duration: 101.195918ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.891625Z","caller":"traceutil/trace.go:171","msg":"trace[168850888] transaction","detail":"{read_only:false; response_revision:5058; number_of_response:1; }","duration":"101.605655ms","start":"2026-09-29T15:42:57.789993Z","end":"2026-09-29T15:42:57.891598Z","steps":["trace[168850888] 'process raft request' (duration: 101.202238ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.891844Z","caller":"traceutil/trace.go:171","msg":"trace[1399962824] transaction","detail":"{read_only:false; response_revision:5060; number_of_response:1; }","duration":"100.72938ms","start":"2026-09-29T15:42:57.79109Z","end":"2026-09-29T15:42:57.891819Z","steps":["trace[1399962824] 'process raft request' (duration: 100.526336ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.891895Z","caller":"traceutil/trace.go:171","msg":"trace[823071668] transaction","detail":"{read_only:false; response_revision:5061; number_of_response:1; }","duration":"100.548867ms","start":"2026-09-29T15:42:57.791299Z","end":"2026-09-29T15:42:57.891848Z","steps":["trace[823071668] 'process raft request' (duration: 100.435815ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.891962Z","caller":"traceutil/trace.go:171","msg":"trace[1116835357] transaction","detail":"{read_only:false; response_revision:5059; number_of_response:1; }","duration":"101.879481ms","start":"2026-09-29T15:42:57.790044Z","end":"2026-09-29T15:42:57.891923Z","steps":["trace[1116835357] 'process raft request' (duration: 101.440952ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:42:57.892207Z","caller":"traceutil/trace.go:171","msg":"trace[1606003948] transaction","detail":"{read_only:false; response_revision:5062; number_of_response:1; }","duration":"100.612968ms","start":"2026-09-29T15:42:57.791576Z","end":"2026-09-29T15:42:57.892189Z","steps":["trace[1606003948] 'process raft request' (duration: 100.223501ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:42:58.062483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.404547ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-29T15:43:10.491663Z","caller":"traceutil/trace.go:171","msg":"trace[1407476118] transaction","detail":"{read_only:false; response_revision:5280; number_of_response:1; }","duration":"165.817304ms","start":"2026-09-29T15:43:10.325821Z","end":"2026-09-29T15:43:10.491638Z","steps":["trace[1407476118] 'process raft request' (duration: 165.617111ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:43:10.606277Z","caller":"traceutil/trace.go:171","msg":"trace[555409739] transaction","detail":"{read_only:false; response_revision:5281; number_of_response:1; }","duration":"109.64612ms","start":"2026-09-29T15:43:10.496582Z","end":"2026-09-29T15:43:10.606228Z","steps":["trace[555409739] 'process raft request' (duration: 76.064542ms)","trace[555409739] 'compare' (duration: 33.377115ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:43:10.60679Z","caller":"traceutil/trace.go:171","msg":"trace[1081946522] transaction","detail":"{read_only:false; response_revision:5282; number_of_response:1; }","duration":"110.137358ms","start":"2026-09-29T15:43:10.496632Z","end":"2026-09-29T15:43:10.60677Z","steps":["trace[1081946522] 'process raft request' (duration: 109.524378ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:43:10.606788Z","caller":"traceutil/trace.go:171","msg":"trace[2025380287] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"106.77999ms","start":"2026-09-29T15:43:10.499971Z","end":"2026-09-29T15:43:10.606751Z","steps":["trace[2025380287] 'process raft request' (duration: 106.601287ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:43:19.137328Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2886} {"level":"info","ts":"2026-09-29T15:43:19.20934Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2886,"took":"70.346505ms","hash":2556298958,"current-db-size-bytes":51167232,"current-db-size":"51 MB","current-db-size-in-use-bytes":27332608,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-29T15:43:19.209397Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2556298958,"revision":2886,"compact-revision":-1} {"level":"info","ts":"2026-09-29T15:46:48.351033Z","caller":"traceutil/trace.go:171","msg":"trace[239682709] transaction","detail":"{read_only:false; response_revision:6881; number_of_response:1; }","duration":"178.380719ms","start":"2026-09-29T15:46:48.172611Z","end":"2026-09-29T15:46:48.350991Z","steps":["trace[239682709] 'process raft request' (duration: 178.095009ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:46:48.377859Z","caller":"traceutil/trace.go:171","msg":"trace[55104922] transaction","detail":"{read_only:false; response_revision:6882; number_of_response:1; }","duration":"181.815063ms","start":"2026-09-29T15:46:48.196018Z","end":"2026-09-29T15:46:48.377833Z","steps":["trace[55104922] 'process raft request' (duration: 181.639907ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:48:19.144052Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5358} {"level":"info","ts":"2026-09-29T15:48:19.224223Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5358,"took":"78.390159ms","hash":1452282735,"current-db-size-bytes":51167232,"current-db-size":"51 MB","current-db-size-in-use-bytes":18767872,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-29T15:48:19.224307Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1452282735,"revision":5358,"compact-revision":2886}