{"level":"warn","ts":"2026-04-22T16:28:08.794013Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-22T16:28:08.794142Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.112: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.19.213.112:2380","--initial-cluster=instance=https://199.19.213.112:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.112:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.112:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-04-22T16:28:08.794227Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-22T16:28:08.794257Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.112:2380"]}
{"level":"info","ts":"2026-04-22T16:28:08.794476Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-22T16:28:08.795205Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"]}
{"level":"info","ts":"2026-04-22T16:28:08.795323Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.112:2380"],"listen-peer-urls":["https://199.19.213.112:2380"],"advertise-client-urls":["https://199.19.213.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.112:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-04-22T16:28:08.799596Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.024217ms"}
{"level":"info","ts":"2026-04-22T16:28:08.805861Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"197930edc5411b2e","cluster-id":"8165613f50a6d530"}
{"level":"info","ts":"2026-04-22T16:28:08.806007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=()"}
{"level":"info","ts":"2026-04-22T16:28:08.80605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became follower at term 0"}
{"level":"info","ts":"2026-04-22T16:28:08.806076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 197930edc5411b2e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-22T16:28:08.806102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became follower at term 1"}
{"level":"info","ts":"2026-04-22T16:28:08.806155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=(1835552120904948526)"}
{"level":"warn","ts":"2026-04-22T16:28:08.818911Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-22T16:28:08.8204Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-22T16:28:08.821594Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-04-22T16:28:08.825401Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"197930edc5411b2e","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-22T16:28:08.825716Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"197930edc5411b2e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-22T16:28:08.8258Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-22T16:28:08.825936Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-22T16:28:08.825959Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-22T16:28:08.827768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=(1835552120904948526)"}
{"level":"info","ts":"2026-04-22T16:28:08.82801Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8165613f50a6d530","local-member-id":"197930edc5411b2e","added-peer-id":"197930edc5411b2e","added-peer-peer-urls":["https://199.19.213.112:2380"]}
{"level":"info","ts":"2026-04-22T16:28:08.829768Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-22T16:28:08.830082Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"197930edc5411b2e","initial-advertise-peer-urls":["https://199.19.213.112:2380"],"listen-peer-urls":["https://199.19.213.112:2380"],"advertise-client-urls":["https://199.19.213.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-22T16:28:08.830131Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-22T16:28:08.830876Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.112:2380"}
{"level":"info","ts":"2026-04-22T16:28:08.830906Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.112:2380"}
{"level":"info","ts":"2026-04-22T16:28:09.406865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e is starting a new election at term 1"}
{"level":"info","ts":"2026-04-22T16:28:09.406952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-22T16:28:09.40698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e received MsgPreVoteResp from 197930edc5411b2e at term 1"}
{"level":"info","ts":"2026-04-22T16:28:09.406995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became candidate at term 2"}
{"level":"info","ts":"2026-04-22T16:28:09.407002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e received MsgVoteResp from 197930edc5411b2e at term 2"}
{"level":"info","ts":"2026-04-22T16:28:09.407013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became leader at term 2"}
{"level":"info","ts":"2026-04-22T16:28:09.407022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 197930edc5411b2e elected leader 197930edc5411b2e at term 2"}
{"level":"info","ts":"2026-04-22T16:28:09.408338Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:28:09.409318Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T16:28:09.409323Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"197930edc5411b2e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.112:2379]}","request-path":"/0/members/197930edc5411b2e/attributes","cluster-id":"8165613f50a6d530","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-22T16:28:09.409432Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T16:28:09.409773Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8165613f50a6d530","local-member-id":"197930edc5411b2e","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:28:09.409894Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:28:09.409949Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:28:09.411014Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-22T16:28:09.411111Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-22T16:28:09.411674Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-22T16:28:09.417241Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.112:2379"}
{"level":"info","ts":"2026-04-22T16:28:29.315673Z","caller":"traceutil/trace.go:171","msg":"trace[1424960913] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"108.156043ms","start":"2026-04-22T16:28:29.207483Z","end":"2026-04-22T16:28:29.315639Z","steps":["trace[1424960913] 'process raft request'  (duration: 108.006089ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:28:47.128649Z","caller":"traceutil/trace.go:171","msg":"trace[1832028922] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"151.405275ms","start":"2026-04-22T16:28:46.977197Z","end":"2026-04-22T16:28:47.128602Z","steps":["trace[1832028922] 'process raft request'  (duration: 101.278076ms)","trace[1832028922] 'compare'  (duration: 49.936044ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:28:47.150617Z","caller":"traceutil/trace.go:171","msg":"trace[760201676] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"171.006318ms","start":"2026-04-22T16:28:46.979566Z","end":"2026-04-22T16:28:47.150572Z","steps":["trace[760201676] 'process raft request'  (duration: 170.806252ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:28:47.15076Z","caller":"traceutil/trace.go:171","msg":"trace[322835320] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"158.718495ms","start":"2026-04-22T16:28:46.992008Z","end":"2026-04-22T16:28:47.150727Z","steps":["trace[322835320] 'process raft request'  (duration: 158.496839ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:28:47.634887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.889267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-46kfd\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-04-22T16:28:47.635044Z","caller":"traceutil/trace.go:171","msg":"trace[2136119173] range","detail":"{range_begin:/registry/pods/kube-system/cilium-46kfd; range_end:; response_count:1; response_revision:580; }","duration":"146.094612ms","start":"2026-04-22T16:28:47.488918Z","end":"2026-04-22T16:28:47.635012Z","steps":["trace[2136119173] 'range keys from in-memory index tree'  (duration: 145.655461ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:28:47.634886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.146642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:28:47.635339Z","caller":"traceutil/trace.go:171","msg":"trace[1437473855] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"371.616794ms","start":"2026-04-22T16:28:47.263683Z","end":"2026-04-22T16:28:47.6353Z","steps":["trace[1437473855] 'range keys from in-memory index tree'  (duration: 371.020708ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:28:47.635603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.719025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-04-22T16:28:47.635592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:28:47.263664Z","time spent":"371.872052ms","remote":"127.0.0.1:33186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-22T16:28:47.635702Z","caller":"traceutil/trace.go:171","msg":"trace[161730625] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"227.861839ms","start":"2026-04-22T16:28:47.407818Z","end":"2026-04-22T16:28:47.635679Z","steps":["trace[161730625] 'range keys from in-memory index tree'  (duration: 226.941923ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:31:08.533773Z","caller":"traceutil/trace.go:171","msg":"trace[2126049102] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2209; }","duration":"102.498331ms","start":"2026-04-22T16:31:08.431252Z","end":"2026-04-22T16:31:08.53375Z","steps":["trace[2126049102] 'read index received'  (duration: 102.398939ms)","trace[2126049102] 'applied index is now lower than readState.Index'  (duration: 98.342µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:31:08.533818Z","caller":"traceutil/trace.go:171","msg":"trace[933738899] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"132.079156ms","start":"2026-04-22T16:31:08.401703Z","end":"2026-04-22T16:31:08.533782Z","steps":["trace[933738899] 'process raft request'  (duration: 131.920102ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:31:08.53399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.720758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T16:31:08.534085Z","caller":"traceutil/trace.go:171","msg":"trace[407476328] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2130; }","duration":"102.902123ms","start":"2026-04-22T16:31:08.431162Z","end":"2026-04-22T16:31:08.534064Z","steps":["trace[407476328] 'agreement among raft nodes before linearized reading'  (duration: 102.712228ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:32:31.184608Z","caller":"traceutil/trace.go:171","msg":"trace[556929514] linearizableReadLoop","detail":"{readStateIndex:2878; appliedIndex:2877; }","duration":"107.403556ms","start":"2026-04-22T16:32:31.077172Z","end":"2026-04-22T16:32:31.184575Z","steps":["trace[556929514] 'read index received'  (duration: 107.026886ms)","trace[556929514] 'applied index is now lower than readState.Index'  (duration: 375.7µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:32:31.184991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.787197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-22T16:32:31.185061Z","caller":"traceutil/trace.go:171","msg":"trace[1796607535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2772; }","duration":"107.905611ms","start":"2026-04-22T16:32:31.077139Z","end":"2026-04-22T16:32:31.185045Z","steps":["trace[1796607535] 'agreement among raft nodes before linearized reading'  (duration: 107.689574ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:32:31.185163Z","caller":"traceutil/trace.go:171","msg":"trace[912510895] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"119.138623ms","start":"2026-04-22T16:32:31.065981Z","end":"2026-04-22T16:32:31.185119Z","steps":["trace[912510895] 'process raft request'  (duration: 118.35302ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:32:31.629554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.300003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:32:31.629652Z","caller":"traceutil/trace.go:171","msg":"trace[1769105762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2773; }","duration":"365.473609ms","start":"2026-04-22T16:32:31.264158Z","end":"2026-04-22T16:32:31.629632Z","steps":["trace[1769105762] 'range keys from in-memory index tree'  (duration: 365.104128ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:32:31.629687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:31.264136Z","time spent":"365.544112ms","remote":"127.0.0.1:33178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-22T16:32:31.629858Z","caller":"traceutil/trace.go:171","msg":"trace[2106650205] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"117.29985ms","start":"2026-04-22T16:32:31.512536Z","end":"2026-04-22T16:32:31.629836Z","steps":["trace[2106650205] 'process raft request'  (duration: 117.172487ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:35:12.162554Z","caller":"traceutil/trace.go:171","msg":"trace[599822348] transaction","detail":"{read_only:false; response_revision:3818; number_of_response:1; }","duration":"106.855255ms","start":"2026-04-22T16:35:12.055673Z","end":"2026-04-22T16:35:12.162528Z","steps":["trace[599822348] 'process raft request'  (duration: 106.443544ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:36:38.677676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.310649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cbb2f645-4f89-4469-a86e-0d26489e2af1\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-04-22T16:36:38.677826Z","caller":"traceutil/trace.go:171","msg":"trace[931389077] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cbb2f645-4f89-4469-a86e-0d26489e2af1; range_end:; response_count:1; response_revision:5011; }","duration":"166.550006ms","start":"2026-04-22T16:36:38.511248Z","end":"2026-04-22T16:36:38.677798Z","steps":["trace[931389077] 'range keys from in-memory index tree'  (duration: 166.070762ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:38.799554Z","caller":"traceutil/trace.go:171","msg":"trace[2102898922] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"111.618497ms","start":"2026-04-22T16:36:38.687902Z","end":"2026-04-22T16:36:38.799521Z","steps":["trace[2102898922] 'process raft request'  (duration: 111.521575ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:38.799672Z","caller":"traceutil/trace.go:171","msg":"trace[406565853] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"116.427796ms","start":"2026-04-22T16:36:38.683196Z","end":"2026-04-22T16:36:38.799624Z","steps":["trace[406565853] 'process raft request'  (duration: 98.570563ms)","trace[406565853] 'compare'  (duration: 17.470212ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:36:38.799687Z","caller":"traceutil/trace.go:171","msg":"trace[172292866] linearizableReadLoop","detail":"{readStateIndex:5204; appliedIndex:5203; }","duration":"114.895112ms","start":"2026-04-22T16:36:38.684746Z","end":"2026-04-22T16:36:38.799642Z","steps":["trace[172292866] 'read index received'  (duration: 97.131501ms)","trace[172292866] 'applied index is now lower than readState.Index'  (duration: 17.759171ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:36:38.799919Z","caller":"traceutil/trace.go:171","msg":"trace[1383818717] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"111.529965ms","start":"2026-04-22T16:36:38.688377Z","end":"2026-04-22T16:36:38.799907Z","steps":["trace[1383818717] 'process raft request'  (duration: 111.095383ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:36:38.800031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.113398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T16:36:38.800046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.414921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-04-22T16:36:38.800079Z","caller":"traceutil/trace.go:171","msg":"trace[1934778622] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5015; }","duration":"152.505063ms","start":"2026-04-22T16:36:38.647567Z","end":"2026-04-22T16:36:38.800072Z","steps":["trace[1934778622] 'agreement among raft nodes before linearized reading'  (duration: 152.256976ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:38.800085Z","caller":"traceutil/trace.go:171","msg":"trace[1790906838] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5015; }","duration":"138.246812ms","start":"2026-04-22T16:36:38.661822Z","end":"2026-04-22T16:36:38.800068Z","steps":["trace[1790906838] 'agreement among raft nodes before linearized reading'  (duration: 137.981544ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:38.800416Z","caller":"traceutil/trace.go:171","msg":"trace[725639162] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"110.284099ms","start":"2026-04-22T16:36:38.690105Z","end":"2026-04-22T16:36:38.800389Z","steps":["trace[725639162] 'process raft request'  (duration: 109.754464ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:36:48.967968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.482614ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958676293049980045 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/specs/openstack/memcached-metrics\" mod_revision:0 > success:<request_put:<key:\"/registry/services/specs/openstack/memcached-metrics\" value_size:690 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-22T16:36:48.968246Z","caller":"traceutil/trace.go:171","msg":"trace[1321094046] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"145.190703ms","start":"2026-04-22T16:36:48.823005Z","end":"2026-04-22T16:36:48.968196Z","steps":["trace[1321094046] 'process raft request'  (duration: 32.878264ms)","trace[1321094046] 'compare'  (duration: 111.300639ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:36:49.211117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.154318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-04-22T16:36:49.211188Z","caller":"traceutil/trace.go:171","msg":"trace[51557688] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5219; }","duration":"131.295463ms","start":"2026-04-22T16:36:49.079878Z","end":"2026-04-22T16:36:49.211174Z","steps":["trace[51557688] 'range keys from in-memory index tree'  (duration: 130.962524ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:36:49.211267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.483149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-bwfvm\" ","response":"range_response_count:1 size:7818"}
{"level":"info","ts":"2026-04-22T16:36:49.21135Z","caller":"traceutil/trace.go:171","msg":"trace[644175180] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-bwfvm; range_end:; response_count:1; response_revision:5219; }","duration":"122.614552ms","start":"2026-04-22T16:36:49.088715Z","end":"2026-04-22T16:36:49.21133Z","steps":["trace[644175180] 'range keys from in-memory index tree'  (duration: 122.285044ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:36:49.504553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.96566ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958676293049980060 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/openstack/memcached-metrics\" mod_revision:5217 > success:<request_put:<key:\"/registry/services/endpoints/openstack/memcached-metrics\" value_size:466 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/memcached-metrics\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T16:36:49.504675Z","caller":"traceutil/trace.go:171","msg":"trace[303335369] transaction","detail":"{read_only:false; response_revision:5221; number_of_response:1; }","duration":"229.784373ms","start":"2026-04-22T16:36:49.274871Z","end":"2026-04-22T16:36:49.504655Z","steps":["trace[303335369] 'process raft request'  (duration: 103.36997ms)","trace[303335369] 'compare'  (duration: 123.633603ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:36:49.513697Z","caller":"traceutil/trace.go:171","msg":"trace[1325673246] linearizableReadLoop","detail":"{readStateIndex:5421; appliedIndex:5418; }","duration":"237.6726ms","start":"2026-04-22T16:36:49.276006Z","end":"2026-04-22T16:36:49.513679Z","steps":["trace[1325673246] 'read index received'  (duration: 102.248229ms)","trace[1325673246] 'applied index is now lower than readState.Index'  (duration: 135.423641ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:36:49.513983Z","caller":"traceutil/trace.go:171","msg":"trace[388764608] transaction","detail":"{read_only:false; response_revision:5222; number_of_response:1; }","duration":"238.415451ms","start":"2026-04-22T16:36:49.275558Z","end":"2026-04-22T16:36:49.513973Z","steps":["trace[388764608] 'process raft request'  (duration: 237.979079ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:49.514204Z","caller":"traceutil/trace.go:171","msg":"trace[2126390188] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"238.587947ms","start":"2026-04-22T16:36:49.275608Z","end":"2026-04-22T16:36:49.514196Z","steps":["trace[2126390188] 'process raft request'  (duration: 238.01118ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:49.514315Z","caller":"traceutil/trace.go:171","msg":"trace[281376721] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"238.02866ms","start":"2026-04-22T16:36:49.276278Z","end":"2026-04-22T16:36:49.514307Z","steps":["trace[281376721] 'process raft request'  (duration: 237.37238ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:36:49.51444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.429123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:36:49.514471Z","caller":"traceutil/trace.go:171","msg":"trace[179276046] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5224; }","duration":"238.501774ms","start":"2026-04-22T16:36:49.275961Z","end":"2026-04-22T16:36:49.514463Z","steps":["trace[179276046] 'agreement among raft nodes before linearized reading'  (duration: 238.441482ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:36:49.51465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.918606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-hrv9q.18a8bb1ecb4a50b9\" ","response":"range_response_count:1 size:906"}
{"level":"info","ts":"2026-04-22T16:36:49.514676Z","caller":"traceutil/trace.go:171","msg":"trace[285791503] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-hrv9q.18a8bb1ecb4a50b9; range_end:; response_count:1; response_revision:5224; }","duration":"135.987028ms","start":"2026-04-22T16:36:49.378682Z","end":"2026-04-22T16:36:49.514669Z","steps":["trace[285791503] 'agreement among raft nodes before linearized reading'  (duration: 135.891075ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:36:49.514958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.215003ms","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-04-22T16:36:49.514987Z","caller":"traceutil/trace.go:171","msg":"trace[2034988309] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5224; }","duration":"122.290125ms","start":"2026-04-22T16:36:49.392688Z","end":"2026-04-22T16:36:49.514979Z","steps":["trace[2034988309] 'agreement among raft nodes before linearized reading'  (duration: 122.226243ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:58.112279Z","caller":"traceutil/trace.go:171","msg":"trace[1167484115] linearizableReadLoop","detail":"{readStateIndex:5627; appliedIndex:5625; }","duration":"138.285585ms","start":"2026-04-22T16:36:57.973971Z","end":"2026-04-22T16:36:58.112256Z","steps":["trace[1167484115] 'read index received'  (duration: 19.547592ms)","trace[1167484115] 'applied index is now lower than readState.Index'  (duration: 118.736353ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:36:58.1123Z","caller":"traceutil/trace.go:171","msg":"trace[90026087] transaction","detail":"{read_only:false; response_revision:5425; number_of_response:1; }","duration":"120.880384ms","start":"2026-04-22T16:36:57.991376Z","end":"2026-04-22T16:36:58.112256Z","steps":["trace[90026087] 'process raft request'  (duration: 120.648517ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:36:58.236129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.137223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-075cc707-1af8-43c8-a19b-e79eab77cbf8\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-04-22T16:36:58.236228Z","caller":"traceutil/trace.go:171","msg":"trace[1340158956] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-075cc707-1af8-43c8-a19b-e79eab77cbf8; range_end:; response_count:1; response_revision:5425; }","duration":"262.282777ms","start":"2026-04-22T16:36:57.973918Z","end":"2026-04-22T16:36:58.236201Z","steps":["trace[1340158956] 'agreement among raft nodes before linearized reading'  (duration: 138.433168ms)","trace[1340158956] 'range keys from in-memory index tree'  (duration: 123.604122ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:36:58.237462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.132445ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958676293049980513 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/prometheus-pushgateway-7b8659c68b-8tkm8.18a8bb24657f391e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/prometheus-pushgateway-7b8659c68b-8tkm8.18a8bb24657f391e\" value_size:672 lease:1958676293049979667 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-22T16:36:58.237744Z","caller":"traceutil/trace.go:171","msg":"trace[1553769565] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"241.078408ms","start":"2026-04-22T16:36:57.996631Z","end":"2026-04-22T16:36:58.237709Z","steps":["trace[1553769565] 'process raft request'  (duration: 115.616803ms)","trace[1553769565] 'compare'  (duration: 123.657124ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:36:58.409619Z","caller":"traceutil/trace.go:171","msg":"trace[1068939325] linearizableReadLoop","detail":"{readStateIndex:5630; appliedIndex:5629; }","duration":"146.688976ms","start":"2026-04-22T16:36:58.262903Z","end":"2026-04-22T16:36:58.409592Z","steps":["trace[1068939325] 'read index received'  (duration: 146.419268ms)","trace[1068939325] 'applied index is now lower than readState.Index'  (duration: 268.648µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:36:58.409872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.938133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:36:58.409919Z","caller":"traceutil/trace.go:171","msg":"trace[1233921278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5427; }","duration":"147.056076ms","start":"2026-04-22T16:36:58.262844Z","end":"2026-04-22T16:36:58.4099Z","steps":["trace[1233921278] 'agreement among raft nodes before linearized reading'  (duration: 146.854401ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:58.410129Z","caller":"traceutil/trace.go:171","msg":"trace[1212006643] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"163.417955ms","start":"2026-04-22T16:36:58.246651Z","end":"2026-04-22T16:36:58.410069Z","steps":["trace[1212006643] 'process raft request'  (duration: 162.743296ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:58.658526Z","caller":"traceutil/trace.go:171","msg":"trace[837604801] transaction","detail":"{read_only:false; response_revision:5428; number_of_response:1; }","duration":"241.853261ms","start":"2026-04-22T16:36:58.416624Z","end":"2026-04-22T16:36:58.658477Z","steps":["trace[837604801] 'process raft request'  (duration: 236.218089ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:58.669794Z","caller":"traceutil/trace.go:171","msg":"trace[2085810598] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"246.73719ms","start":"2026-04-22T16:36:58.423034Z","end":"2026-04-22T16:36:58.669771Z","steps":["trace[2085810598] 'process raft request'  (duration: 246.673118ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:58.669862Z","caller":"traceutil/trace.go:171","msg":"trace[353230608] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"251.037195ms","start":"2026-04-22T16:36:58.418767Z","end":"2026-04-22T16:36:58.669804Z","steps":["trace[353230608] 'process raft request'  (duration: 250.785087ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:37:08.445547Z","caller":"traceutil/trace.go:171","msg":"trace[1110455389] transaction","detail":"{read_only:false; response_revision:5551; number_of_response:1; }","duration":"101.146586ms","start":"2026-04-22T16:37:08.344362Z","end":"2026-04-22T16:37:08.445508Z","steps":["trace[1110455389] 'process raft request'  (duration: 100.94558ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:38:09.437122Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2982}
{"level":"info","ts":"2026-04-22T16:38:09.507245Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2982,"took":"68.528419ms","hash":3201885726,"current-db-size-bytes":57102336,"current-db-size":"57 MB","current-db-size-in-use-bytes":33525760,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-04-22T16:38:09.507321Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3201885726,"revision":2982,"compact-revision":-1}
{"level":"info","ts":"2026-04-22T16:43:05.706457Z","caller":"traceutil/trace.go:171","msg":"trace[1597828411] transaction","detail":"{read_only:false; response_revision:8237; number_of_response:1; }","duration":"119.364659ms","start":"2026-04-22T16:43:05.587069Z","end":"2026-04-22T16:43:05.706433Z","steps":["trace[1597828411] 'process raft request'  (duration: 119.200784ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:43:09.444021Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6061}
{"level":"info","ts":"2026-04-22T16:43:09.539868Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6061,"took":"94.127251ms","hash":23916443,"current-db-size-bytes":57102336,"current-db-size":"57 MB","current-db-size-in-use-bytes":23683072,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-04-22T16:43:09.539956Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":23916443,"revision":6061,"compact-revision":2982}
{"level":"info","ts":"2026-04-22T16:43:16.641461Z","caller":"traceutil/trace.go:171","msg":"trace[1250644946] transaction","detail":"{read_only:false; response_revision:8297; number_of_response:1; }","duration":"176.588244ms","start":"2026-04-22T16:43:16.464841Z","end":"2026-04-22T16:43:16.641429Z","steps":["trace[1250644946] 'process raft request'  (duration: 93.647467ms)","trace[1250644946] 'compare'  (duration: 82.810904ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:43:43.415919Z","caller":"traceutil/trace.go:171","msg":"trace[775860576] linearizableReadLoop","detail":"{readStateIndex:8794; appliedIndex:8793; }","duration":"186.364426ms","start":"2026-04-22T16:43:43.229536Z","end":"2026-04-22T16:43:43.415901Z","steps":["trace[775860576] 'read index received'  (duration: 186.198161ms)","trace[775860576] 'applied index is now lower than readState.Index'  (duration: 165.635µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:43:43.41602Z","caller":"traceutil/trace.go:171","msg":"trace[203393319] transaction","detail":"{read_only:false; response_revision:8493; number_of_response:1; }","duration":"187.577731ms","start":"2026-04-22T16:43:43.228433Z","end":"2026-04-22T16:43:43.416011Z","steps":["trace[203393319] 'process raft request'  (duration: 187.349915ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:43:43.416248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.911539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:43:43.416273Z","caller":"traceutil/trace.go:171","msg":"trace[1745649586] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8493; }","duration":"152.980621ms","start":"2026-04-22T16:43:43.263286Z","end":"2026-04-22T16:43:43.416266Z","steps":["trace[1745649586] 'agreement among raft nodes before linearized reading'  (duration: 152.931889ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:43:43.416952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.344695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-22T16:43:43.417284Z","caller":"traceutil/trace.go:171","msg":"trace[373009011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8493; }","duration":"187.586731ms","start":"2026-04-22T16:43:43.229512Z","end":"2026-04-22T16:43:43.417099Z","steps":["trace[373009011] 'agreement among raft nodes before linearized reading'  (duration: 186.683505ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:43:56.075148Z","caller":"traceutil/trace.go:171","msg":"trace[381388819] linearizableReadLoop","detail":"{readStateIndex:8908; appliedIndex:8907; }","duration":"106.737985ms","start":"2026-04-22T16:43:55.968391Z","end":"2026-04-22T16:43:56.075129Z","steps":["trace[381388819] 'read index received'  (duration: 106.590521ms)","trace[381388819] 'applied index is now lower than readState.Index'  (duration: 146.594µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:43:56.075561Z","caller":"traceutil/trace.go:171","msg":"trace[1953676872] transaction","detail":"{read_only:false; response_revision:8601; number_of_response:1; }","duration":"178.895201ms","start":"2026-04-22T16:43:55.896655Z","end":"2026-04-22T16:43:56.075551Z","steps":["trace[1953676872] 'process raft request'  (duration: 178.302214ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:43:56.075816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.405444ms","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-04-22T16:43:56.075883Z","caller":"traceutil/trace.go:171","msg":"trace[446657191] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8601; }","duration":"107.507777ms","start":"2026-04-22T16:43:55.968358Z","end":"2026-04-22T16:43:56.075866Z","steps":["trace[446657191] 'agreement among raft nodes before linearized reading'  (duration: 107.317232ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:43:56.075854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.264697ms","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-04-22T16:43:56.075952Z","caller":"traceutil/trace.go:171","msg":"trace[579779445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8601; }","duration":"100.418792ms","start":"2026-04-22T16:43:55.975508Z","end":"2026-04-22T16:43:56.075927Z","steps":["trace[579779445] 'agreement among raft nodes before linearized reading'  (duration: 100.145154ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:43:56.968408Z","caller":"traceutil/trace.go:171","msg":"trace[2050187104] transaction","detail":"{read_only:false; response_revision:8609; number_of_response:1; }","duration":"302.076041ms","start":"2026-04-22T16:43:56.666305Z","end":"2026-04-22T16:43:56.968381Z","steps":["trace[2050187104] 'process raft request'  (duration: 210.00792ms)","trace[2050187104] 'compare'  (duration: 91.860295ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:43:56.968549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:43:56.666295Z","time spent":"302.177334ms","remote":"127.0.0.1:33268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-9nr9d.18a8bb85e003c190\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-9nr9d.18a8bb85e003c190\" value_size:654 lease:1958676293049988076 >> failure:<>"}
{"level":"info","ts":"2026-04-22T16:43:56.987956Z","caller":"traceutil/trace.go:171","msg":"trace[2022532309] transaction","detail":"{read_only:false; response_revision:8612; number_of_response:1; }","duration":"191.410082ms","start":"2026-04-22T16:43:56.796511Z","end":"2026-04-22T16:43:56.987921Z","steps":["trace[2022532309] 'process raft request'  (duration: 191.356541ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:43:56.988686Z","caller":"traceutil/trace.go:171","msg":"trace[2014220642] transaction","detail":"{read_only:false; response_revision:8610; number_of_response:1; }","duration":"317.891327ms","start":"2026-04-22T16:43:56.67077Z","end":"2026-04-22T16:43:56.988662Z","steps":["trace[2014220642] 'process raft request'  (duration: 316.883518ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:43:56.988752Z","caller":"traceutil/trace.go:171","msg":"trace[815117411] transaction","detail":"{read_only:false; response_revision:8611; number_of_response:1; }","duration":"278.609983ms","start":"2026-04-22T16:43:56.7101Z","end":"2026-04-22T16:43:56.98871Z","steps":["trace[815117411] 'process raft request'  (duration: 277.714017ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:43:56.988851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:43:56.670765Z","time spent":"317.98478ms","remote":"127.0.0.1:33420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/rook-ceph-detect-version\" mod_revision:8598 > success:<request_put:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" value_size:2980 >> failure:<request_range:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" > >"}
{"level":"info","ts":"2026-04-22T16:43:57.823077Z","caller":"traceutil/trace.go:171","msg":"trace[366928988] linearizableReadLoop","detail":"{readStateIndex:8926; appliedIndex:8925; }","duration":"142.91374ms","start":"2026-04-22T16:43:57.68014Z","end":"2026-04-22T16:43:57.823054Z","steps":["trace[366928988] 'read index received'  (duration: 142.669543ms)","trace[366928988] 'applied index is now lower than readState.Index'  (duration: 243.387µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:43:57.823167Z","caller":"traceutil/trace.go:171","msg":"trace[377516826] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"155.900366ms","start":"2026-04-22T16:43:57.667244Z","end":"2026-04-22T16:43:57.823144Z","steps":["trace[377516826] 'process raft request'  (duration: 155.648209ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:43:57.823248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.082186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T16:43:57.823297Z","caller":"traceutil/trace.go:171","msg":"trace[1744212873] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:8619; }","duration":"143.172848ms","start":"2026-04-22T16:43:57.680112Z","end":"2026-04-22T16:43:57.823285Z","steps":["trace[1744212873] 'agreement among raft nodes before linearized reading'  (duration: 143.074195ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:32.54014Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002438.wal"}
{"level":"info","ts":"2026-04-22T16:45:08.729496Z","caller":"traceutil/trace.go:171","msg":"trace[2020064549] transaction","detail":"{read_only:false; response_revision:9329; number_of_response:1; }","duration":"104.526321ms","start":"2026-04-22T16:45:08.624929Z","end":"2026-04-22T16:45:08.729455Z","steps":["trace[2020064549] 'process raft request'  (duration: 104.297295ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:08.897432Z","caller":"traceutil/trace.go:171","msg":"trace[1678099988] linearizableReadLoop","detail":"{readStateIndex:9657; appliedIndex:9656; }","duration":"107.741663ms","start":"2026-04-22T16:45:08.789655Z","end":"2026-04-22T16:45:08.897397Z","steps":["trace[1678099988] 'read index received'  (duration: 64.72168ms)","trace[1678099988] 'applied index is now lower than readState.Index'  (duration: 43.018273ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:45:08.897623Z","caller":"traceutil/trace.go:171","msg":"trace[1193902494] transaction","detail":"{read_only:false; response_revision:9330; number_of_response:1; }","duration":"126.336301ms","start":"2026-04-22T16:45:08.771267Z","end":"2026-04-22T16:45:08.897603Z","steps":["trace[1193902494] 'process raft request'  (duration: 83.119153ms)","trace[1193902494] 'compare'  (duration: 42.829787ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:45:08.897953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.274799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:45:08.898062Z","caller":"traceutil/trace.go:171","msg":"trace[334981165] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:9330; }","duration":"108.429654ms","start":"2026-04-22T16:45:08.789606Z","end":"2026-04-22T16:45:08.898036Z","steps":["trace[334981165] 'agreement among raft nodes before linearized reading'  (duration: 108.257919ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:45:09.050844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.746855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:45:09.050914Z","caller":"traceutil/trace.go:171","msg":"trace[664260574] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:9333; }","duration":"116.866908ms","start":"2026-04-22T16:45:08.934031Z","end":"2026-04-22T16:45:09.050898Z","steps":["trace[664260574] 'agreement among raft nodes before linearized reading'  (duration: 116.741525ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:09.050911Z","caller":"traceutil/trace.go:171","msg":"trace[356882780] transaction","detail":"{read_only:false; response_revision:9333; number_of_response:1; }","duration":"105.470948ms","start":"2026-04-22T16:45:08.94539Z","end":"2026-04-22T16:45:09.050861Z","steps":["trace[356882780] 'process raft request'  (duration: 94.065389ms)","trace[356882780] 'compare'  (duration: 11.212394ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:45:54.962641Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"197930edc5411b2e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-22T16:45:54.991398Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-22T16:45:54.99156Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-22T16:48:09.454405Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8258}
{"level":"info","ts":"2026-04-22T16:48:09.534463Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8258,"took":"77.82831ms","hash":875316220,"current-db-size-bytes":57102336,"current-db-size":"57 MB","current-db-size-in-use-bytes":24866816,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-04-22T16:48:09.534548Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":875316220,"revision":8258,"compact-revision":6061}
{"level":"info","ts":"2026-04-22T16:53:09.459905Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10655}
{"level":"info","ts":"2026-04-22T16:53:09.542094Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10655,"took":"79.96998ms","hash":3005883972,"current-db-size-bytes":57102336,"current-db-size":"57 MB","current-db-size-in-use-bytes":20418560,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-04-22T16:53:09.542184Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3005883972,"revision":10655,"compact-revision":8258}