{"level":"warn","ts":"2026-05-29T04:59:12.347719Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-29T04:59:12.34782Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-05-29T04:59:12.347905Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-29T04:59:12.347923Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-29T04:59:12.347941Z","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-05-29T04:59:12.348579Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-05-29T04:59:12.348657Z","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.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-05-29T04:59:12.353448Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.566816ms"} {"level":"info","ts":"2026-05-29T04:59:12.364259Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-05-29T04:59:12.364422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-05-29T04:59:12.364452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-05-29T04:59:12.364475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-29T04:59:12.364494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-05-29T04:59:12.364549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-05-29T04:59:12.373364Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-29T04:59:12.374649Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-29T04:59:12.375459Z","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-05-29T04:59:12.377814Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-29T04:59:12.378049Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-29T04:59:12.378388Z","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-05-29T04:59:12.378491Z","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-05-29T04:59:12.378508Z","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-05-29T04:59:12.380548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-05-29T04:59:12.38083Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-29T04:59:12.38306Z","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-05-29T04:59:12.38327Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-29T04:59:12.383453Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-29T04:59:12.384196Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-29T04:59:12.384276Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-29T04:59:13.266526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-05-29T04:59:13.266591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-05-29T04:59:13.26662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-05-29T04:59:13.266641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-05-29T04:59:13.266658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-29T04:59:13.2667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-05-29T04:59:13.266751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-29T04:59:13.267524Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-05-29T04:59:13.267566Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T04:59:13.267601Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T04:59:13.267803Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T04:59:13.267985Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-29T04:59:13.268054Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-29T04:59:13.268847Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T04:59:13.268946Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T04:59:13.268983Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T04:59:13.271584Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-29T04:59:13.272105Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-05-29T04:59:28.829315Z","caller":"traceutil/trace.go:171","msg":"trace[712209864] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"148.391169ms","start":"2026-05-29T04:59:28.680897Z","end":"2026-05-29T04:59:28.829288Z","steps":["trace[712209864] 'process raft request' (duration: 136.804156ms)","trace[712209864] 'compare' (duration: 11.487477ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T04:59:28.909495Z","caller":"traceutil/trace.go:171","msg":"trace[1442613339] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:421; }","duration":"175.788257ms","start":"2026-05-29T04:59:28.733683Z","end":"2026-05-29T04:59:28.909471Z","steps":["trace[1442613339] 'read index received' (duration: 83.940805ms)","trace[1442613339] 'applied index is now lower than readState.Index' (duration: 91.846162ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T04:59:28.909538Z","caller":"traceutil/trace.go:171","msg":"trace[343019564] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"228.241775ms","start":"2026-05-29T04:59:28.681266Z","end":"2026-05-29T04:59:28.909508Z","steps":["trace[343019564] 'process raft request' (duration: 228.106467ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T04:59:28.909654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.943055ms","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-05-29T04:59:28.909747Z","caller":"traceutil/trace.go:171","msg":"trace[1361366324] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:413; }","duration":"176.087443ms","start":"2026-05-29T04:59:28.733641Z","end":"2026-05-29T04:59:28.909728Z","steps":["trace[1361366324] 'agreement among raft nodes before linearized reading' (duration: 175.919564ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T04:59:54.946287Z","caller":"traceutil/trace.go:171","msg":"trace[169479190] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"117.571928ms","start":"2026-05-29T04:59:54.828696Z","end":"2026-05-29T04:59:54.946268Z","steps":["trace[169479190] 'process raft request' (duration: 117.202814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T04:59:55.140135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.436009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-29T04:59:55.140287Z","caller":"traceutil/trace.go:171","msg":"trace[1864093198] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"109.958013ms","start":"2026-05-29T04:59:55.030289Z","end":"2026-05-29T04:59:55.140247Z","steps":["trace[1864093198] 'read index received' (duration: 41.389µs)","trace[1864093198] 'applied index is now lower than readState.Index' (duration: 109.915024ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T04:59:55.140316Z","caller":"traceutil/trace.go:171","msg":"trace[513927986] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"134.089306ms","start":"2026-05-29T04:59:55.006193Z","end":"2026-05-29T04:59:55.140282Z","steps":["trace[513927986] 'process raft request' (duration: 15.845569ms)","trace[513927986] 'compare' (duration: 117.287262ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T04:59:55.140497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.20174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-29T04:59:55.140558Z","caller":"traceutil/trace.go:171","msg":"trace[1564158505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"110.291228ms","start":"2026-05-29T04:59:55.03025Z","end":"2026-05-29T04:59:55.140541Z","steps":["trace[1564158505] 'agreement among raft nodes before linearized reading' (duration: 110.105581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T04:59:55.446361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.800955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T04:59:55.44664Z","caller":"traceutil/trace.go:171","msg":"trace[96783412] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:650; }","duration":"293.535224ms","start":"2026-05-29T04:59:55.153083Z","end":"2026-05-29T04:59:55.446619Z","steps":["trace[96783412] 'read index received' (duration: 1.801572ms)","trace[96783412] 'applied index is now lower than readState.Index' (duration: 291.732562ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T04:59:55.446648Z","caller":"traceutil/trace.go:171","msg":"trace[728650493] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"299.600632ms","start":"2026-05-29T04:59:55.147017Z","end":"2026-05-29T04:59:55.446618Z","steps":["trace[728650493] 'process raft request' (duration: 299.425735ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T04:59:55.446934Z","caller":"traceutil/trace.go:171","msg":"trace[1364690315] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"292.105576ms","start":"2026-05-29T04:59:55.154793Z","end":"2026-05-29T04:59:55.446899Z","steps":["trace[1364690315] 'process raft request' (duration: 291.716992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T04:59:55.447098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.004647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T04:59:55.447148Z","caller":"traceutil/trace.go:171","msg":"trace[2083640748] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:634; }","duration":"294.083065ms","start":"2026-05-29T04:59:55.153053Z","end":"2026-05-29T04:59:55.447136Z","steps":["trace[2083640748] 'agreement among raft nodes before linearized reading' (duration: 293.634412ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T04:59:55.447544Z","caller":"traceutil/trace.go:171","msg":"trace[427888552] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"299.800349ms","start":"2026-05-29T04:59:55.146915Z","end":"2026-05-29T04:59:55.446715Z","steps":["trace[427888552] 'process raft request' (duration: 185.216795ms)","trace[427888552] 'compare' (duration: 113.658288ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T04:59:55.447622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T04:59:55.146894Z","time spent":"300.690146ms","remote":"127.0.0.1:56248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T04:59:55.900007Z","caller":"traceutil/trace.go:171","msg":"trace[1887190735] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"283.439879ms","start":"2026-05-29T04:59:55.616531Z","end":"2026-05-29T04:59:55.89997Z","steps":["trace[1887190735] 'process raft request' (duration: 258.007607ms)","trace[1887190735] 'compare' (duration: 25.176296ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:00:11.638074Z","caller":"traceutil/trace.go:171","msg":"trace[203885996] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:821; }","duration":"119.59812ms","start":"2026-05-29T05:00:11.518453Z","end":"2026-05-29T05:00:11.638051Z","steps":["trace[203885996] 'read index received' (duration: 117.238722ms)","trace[203885996] 'applied index is now lower than readState.Index' (duration: 2.357588ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:00:11.638271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.72767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-29T05:00:11.638272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.80481ms","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-05-29T05:00:11.638303Z","caller":"traceutil/trace.go:171","msg":"trace[1002486516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:797; }","duration":"119.79685ms","start":"2026-05-29T05:00:11.518497Z","end":"2026-05-29T05:00:11.638294Z","steps":["trace[1002486516] 'agreement among raft nodes before linearized reading' (duration: 119.67835ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:00:11.638322Z","caller":"traceutil/trace.go:171","msg":"trace[263305004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:797; }","duration":"119.8998ms","start":"2026-05-29T05:00:11.518407Z","end":"2026-05-29T05:00:11.638307Z","steps":["trace[263305004] 'agreement among raft nodes before linearized reading' (duration: 119.74519ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:00:39.904178Z","caller":"traceutil/trace.go:171","msg":"trace[791871440] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"124.814618ms","start":"2026-05-29T05:00:39.779336Z","end":"2026-05-29T05:00:39.904151Z","steps":["trace[791871440] 'process raft request' (duration: 124.668554ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:00:39.927526Z","caller":"traceutil/trace.go:171","msg":"trace[1098502337] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"148.071117ms","start":"2026-05-29T05:00:39.779431Z","end":"2026-05-29T05:00:39.927502Z","steps":["trace[1098502337] 'process raft request' (duration: 147.909374ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:00:51.096241Z","caller":"traceutil/trace.go:171","msg":"trace[301467815] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"144.922741ms","start":"2026-05-29T05:00:50.951278Z","end":"2026-05-29T05:00:51.0962Z","steps":["trace[301467815] 'process raft request' (duration: 104.170384ms)","trace[301467815] 'compare' (duration: 40.169994ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:01:23.698549Z","caller":"traceutil/trace.go:171","msg":"trace[1219425745] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"186.752159ms","start":"2026-05-29T05:01:23.511752Z","end":"2026-05-29T05:01:23.698504Z","steps":["trace[1219425745] 'process raft request' (duration: 174.432376ms)","trace[1219425745] 'compare' (duration: 12.039104ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:01:31.860519Z","caller":"traceutil/trace.go:171","msg":"trace[930598564] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"108.884838ms","start":"2026-05-29T05:01:31.751605Z","end":"2026-05-29T05:01:31.86049Z","steps":["trace[930598564] 'process raft request' (duration: 108.675801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:01:52.449655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.027052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:01:52.449739Z","caller":"traceutil/trace.go:171","msg":"trace[1522350593] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"122.661631ms","start":"2026-05-29T05:01:52.327065Z","end":"2026-05-29T05:01:52.449726Z","steps":["trace[1522350593] 'process raft request' (duration: 17.493514ms)","trace[1522350593] 'compare' (duration: 104.684749ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:01:57.987992Z","caller":"traceutil/trace.go:171","msg":"trace[1171580837] linearizableReadLoop","detail":"{readStateIndex:2165; appliedIndex:2164; }","duration":"158.83757ms","start":"2026-05-29T05:01:57.829132Z","end":"2026-05-29T05:01:57.98797Z","steps":["trace[1171580837] 'read index received' (duration: 158.681454ms)","trace[1171580837] 'applied index is now lower than readState.Index' (duration: 154.936µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:01:57.988168Z","caller":"traceutil/trace.go:171","msg":"trace[1330452472] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"199.326492ms","start":"2026-05-29T05:01:57.788821Z","end":"2026-05-29T05:01:57.988148Z","steps":["trace[1330452472] 'process raft request' (duration: 199.037081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:01:57.988381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.236105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"info","ts":"2026-05-29T05:01:57.988478Z","caller":"traceutil/trace.go:171","msg":"trace[1685225072] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2089; }","duration":"159.382641ms","start":"2026-05-29T05:01:57.829078Z","end":"2026-05-29T05:01:57.988461Z","steps":["trace[1685225072] 'agreement among raft nodes before linearized reading' (duration: 159.023077ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:01:58.762592Z","caller":"traceutil/trace.go:171","msg":"trace[1965117001] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"170.541775ms","start":"2026-05-29T05:01:58.592019Z","end":"2026-05-29T05:01:58.762561Z","steps":["trace[1965117001] 'process raft request' (duration: 107.801587ms)","trace[1965117001] 'compare' (duration: 62.620693ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:03:03.188635Z","caller":"traceutil/trace.go:171","msg":"trace[1909523182] transaction","detail":"{read_only:false; response_revision:2541; number_of_response:1; }","duration":"212.977585ms","start":"2026-05-29T05:03:02.975628Z","end":"2026-05-29T05:03:03.188605Z","steps":["trace[1909523182] 'process raft request' (duration: 212.533155ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:03:03.18948Z","caller":"traceutil/trace.go:171","msg":"trace[1960417875] linearizableReadLoop","detail":"{readStateIndex:2633; appliedIndex:2631; }","duration":"160.054705ms","start":"2026-05-29T05:03:03.029361Z","end":"2026-05-29T05:03:03.189415Z","steps":["trace[1960417875] 'read index received' (duration: 158.753536ms)","trace[1960417875] 'applied index is now lower than readState.Index' (duration: 1.299699ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:03:03.189839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.333641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:03:03.189575Z","caller":"traceutil/trace.go:171","msg":"trace[1597123006] transaction","detail":"{read_only:false; response_revision:2542; number_of_response:1; }","duration":"204.965852ms","start":"2026-05-29T05:03:02.984575Z","end":"2026-05-29T05:03:03.189541Z","steps":["trace[1597123006] 'process raft request' (duration: 204.426858ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:03:03.190304Z","caller":"traceutil/trace.go:171","msg":"trace[1284163589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2542; }","duration":"118.822113ms","start":"2026-05-29T05:03:03.071421Z","end":"2026-05-29T05:03:03.190243Z","steps":["trace[1284163589] 'agreement among raft nodes before linearized reading' (duration: 118.330951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:03:03.189933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.574638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-29T05:03:03.190668Z","caller":"traceutil/trace.go:171","msg":"trace[1730597811] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2542; }","duration":"161.379175ms","start":"2026-05-29T05:03:03.02927Z","end":"2026-05-29T05:03:03.190649Z","steps":["trace[1730597811] 'agreement among raft nodes before linearized reading' (duration: 160.416171ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:07:27.526918Z","caller":"traceutil/trace.go:171","msg":"trace[1676109848] transaction","detail":"{read_only:false; response_revision:4607; number_of_response:1; }","duration":"128.93937ms","start":"2026-05-29T05:07:27.397954Z","end":"2026-05-29T05:07:27.526893Z","steps":["trace[1676109848] 'process raft request' (duration: 128.413604ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:07:29.88848Z","caller":"traceutil/trace.go:171","msg":"trace[1279036214] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"128.262764ms","start":"2026-05-29T05:07:29.760173Z","end":"2026-05-29T05:07:29.888436Z","steps":["trace[1279036214] 'process raft request' (duration: 128.077817ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:07:43.671045Z","caller":"traceutil/trace.go:171","msg":"trace[2132204195] linearizableReadLoop","detail":"{readStateIndex:5088; appliedIndex:5087; }","duration":"211.787926ms","start":"2026-05-29T05:07:43.459233Z","end":"2026-05-29T05:07:43.671021Z","steps":["trace[2132204195] 'read index received' (duration: 211.570599ms)","trace[2132204195] 'applied index is now lower than readState.Index' (duration: 215.887µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:07:43.671088Z","caller":"traceutil/trace.go:171","msg":"trace[48498485] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"260.943343ms","start":"2026-05-29T05:07:43.410115Z","end":"2026-05-29T05:07:43.671059Z","steps":["trace[48498485] 'process raft request' (duration: 260.751317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:07:43.67124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.984651ms","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-05-29T05:07:43.671285Z","caller":"traceutil/trace.go:171","msg":"trace[254538438] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4907; }","duration":"212.067895ms","start":"2026-05-29T05:07:43.459205Z","end":"2026-05-29T05:07:43.671273Z","steps":["trace[254538438] 'agreement among raft nodes before linearized reading' (duration: 211.91284ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:07:43.798862Z","caller":"traceutil/trace.go:171","msg":"trace[2022181051] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"120.228274ms","start":"2026-05-29T05:07:43.678582Z","end":"2026-05-29T05:07:43.79881Z","steps":["trace[2022181051] 'process raft request' (duration: 120.041619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:07:43.799352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.637406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-7064f5b6-df63-4ff6-a4ef-ae8896a64da8\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-05-29T05:07:43.799061Z","caller":"traceutil/trace.go:171","msg":"trace[451511229] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"120.293306ms","start":"2026-05-29T05:07:43.678745Z","end":"2026-05-29T05:07:43.799039Z","steps":["trace[451511229] 'process raft request' (duration: 120.010398ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:07:43.799472Z","caller":"traceutil/trace.go:171","msg":"trace[1178346982] range","detail":"{range_begin:/registry/persistentvolumes/pvc-7064f5b6-df63-4ff6-a4ef-ae8896a64da8; range_end:; response_count:1; response_revision:4911; }","duration":"120.789871ms","start":"2026-05-29T05:07:43.678647Z","end":"2026-05-29T05:07:43.799437Z","steps":["trace[1178346982] 'agreement among raft nodes before linearized reading' (duration: 120.507352ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:07:43.799144Z","caller":"traceutil/trace.go:171","msg":"trace[450682062] linearizableReadLoop","detail":"{readStateIndex:5091; appliedIndex:5088; }","duration":"120.446611ms","start":"2026-05-29T05:07:43.678686Z","end":"2026-05-29T05:07:43.799133Z","steps":["trace[450682062] 'read index received' (duration: 60.391496ms)","trace[450682062] 'applied index is now lower than readState.Index' (duration: 59.713505ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:07:43.799325Z","caller":"traceutil/trace.go:171","msg":"trace[541171370] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"120.631936ms","start":"2026-05-29T05:07:43.67867Z","end":"2026-05-29T05:07:43.799302Z","steps":["trace[541171370] 'process raft request' (duration: 120.038098ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:09:13.300901Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2919} {"level":"info","ts":"2026-05-29T05:09:13.3784Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2919,"took":"76.428488ms","hash":2543748434,"current-db-size-bytes":53788672,"current-db-size":"54 MB","current-db-size-in-use-bytes":29675520,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-29T05:09:13.378483Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2543748434,"revision":2919,"compact-revision":-1} {"level":"info","ts":"2026-05-29T05:14:13.305439Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5677} {"level":"info","ts":"2026-05-29T05:14:13.382644Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5677,"took":"75.99965ms","hash":294685771,"current-db-size-bytes":53788672,"current-db-size":"54 MB","current-db-size-in-use-bytes":18280448,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-29T05:14:13.383098Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":294685771,"revision":5677,"compact-revision":2919}