{"level":"warn","ts":"2026-04-16T22:48:01.65751Z","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-16T22:48:01.657611Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-16T22:48:01.657696Z","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-16T22:48:01.657719Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-04-16T22:48:01.657748Z","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-16T22:48:01.65857Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-04-16T22:48:01.658656Z","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.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-16T22:48:01.662281Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.411053ms"} {"level":"info","ts":"2026-04-16T22:48:01.668476Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-04-16T22:48:01.668571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T22:48:01.668597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-04-16T22:48:01.668614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T22:48:01.668627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-04-16T22:48:01.668675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-04-16T22:48:01.674123Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T22:48:01.677223Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T22:48:01.67871Z","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-16T22:48:01.681194Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T22:48:01.681328Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T22:48:01.681724Z","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-16T22:48:01.681901Z","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-16T22:48:01.681984Z","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-16T22:48:01.684206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-04-16T22:48:01.684406Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-04-16T22:48:01.686041Z","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-16T22:48:01.686157Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-04-16T22:48:01.686225Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-04-16T22:48:01.686333Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T22:48:01.686371Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T22:48:02.669756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T22:48:02.669825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T22:48:02.669875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-04-16T22:48:02.669893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-04-16T22:48:02.6699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-04-16T22:48:02.670014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-04-16T22:48:02.670026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-04-16T22:48:02.682691Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:48:02.683624Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T22:48:02.683619Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T22:48:02.683692Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T22:48:02.68402Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T22:48:02.684184Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T22:48:02.684379Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:48:02.684663Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:48:02.684751Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:48:02.687741Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T22:48:02.688225Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-04-16T22:48:32.734427Z","caller":"traceutil/trace.go:171","msg":"trace[1477479506] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"106.446487ms","start":"2026-04-16T22:48:32.627956Z","end":"2026-04-16T22:48:32.734402Z","steps":["trace[1477479506] 'process raft request' (duration: 99.091786ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:48:32.735102Z","caller":"traceutil/trace.go:171","msg":"trace[1421118198] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"102.403347ms","start":"2026-04-16T22:48:32.632671Z","end":"2026-04-16T22:48:32.735075Z","steps":["trace[1421118198] 'process raft request' (duration: 102.11782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:48:38.804428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.962681ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T22:48:38.804616Z","caller":"traceutil/trace.go:171","msg":"trace[1825551743] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"256.123754ms","start":"2026-04-16T22:48:38.548449Z","end":"2026-04-16T22:48:38.804573Z","steps":["trace[1825551743] 'process raft request' (duration: 113.195958ms)","trace[1825551743] 'compare' (duration: 141.844099ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:48:38.901291Z","caller":"traceutil/trace.go:171","msg":"trace[580444564] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:601; }","duration":"295.972091ms","start":"2026-04-16T22:48:38.605285Z","end":"2026-04-16T22:48:38.901257Z","steps":["trace[580444564] 'read index received' (duration: 56.382298ms)","trace[580444564] 'applied index is now lower than readState.Index' (duration: 239.587723ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:48:38.90137Z","caller":"traceutil/trace.go:171","msg":"trace[1262009578] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"326.049278ms","start":"2026-04-16T22:48:38.575298Z","end":"2026-04-16T22:48:38.901347Z","steps":["trace[1262009578] 'process raft request' (duration: 325.800712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:48:38.901513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:48:38.575262Z","time spent":"326.159ms","remote":"127.0.0.1:42024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T22:48:38.901604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.79633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5tn2s\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-16T22:48:38.901693Z","caller":"traceutil/trace.go:171","msg":"trace[1663486451] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5tn2s; range_end:; response_count:1; response_revision:582; }","duration":"277.954345ms","start":"2026-04-16T22:48:38.623718Z","end":"2026-04-16T22:48:38.901672Z","steps":["trace[1663486451] 'agreement among raft nodes before linearized reading' (duration: 277.76603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:48:38.90168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.375681ms","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-04-16T22:48:38.901748Z","caller":"traceutil/trace.go:171","msg":"trace[1671023947] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"296.510744ms","start":"2026-04-16T22:48:38.605218Z","end":"2026-04-16T22:48:38.901729Z","steps":["trace[1671023947] 'agreement among raft nodes before linearized reading' (duration: 296.203927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:48:39.372374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.057883ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T22:48:39.372578Z","caller":"traceutil/trace.go:171","msg":"trace[1647677947] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"456.881244ms","start":"2026-04-16T22:48:38.91568Z","end":"2026-04-16T22:48:39.372561Z","steps":["trace[1647677947] 'process raft request' (duration: 456.814632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:48:39.372636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:48:38.915647Z","time spent":"456.965637ms","remote":"127.0.0.1:41706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T22:48:39.372691Z","caller":"traceutil/trace.go:171","msg":"trace[567423047] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"465.457347ms","start":"2026-04-16T22:48:38.9072Z","end":"2026-04-16T22:48:39.372657Z","steps":["trace[567423047] 'process raft request' (duration: 11.020813ms)","trace[567423047] 'compare' (duration: 453.784737ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:48:39.372646Z","caller":"traceutil/trace.go:171","msg":"trace[73832342] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"458.725629ms","start":"2026-04-16T22:48:38.91388Z","end":"2026-04-16T22:48:39.372606Z","steps":["trace[73832342] 'read index received' (duration: 4.408049ms)","trace[73832342] 'applied index is now lower than readState.Index' (duration: 454.3137ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:48:39.372867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:48:38.907178Z","time spent":"465.59074ms","remote":"127.0.0.1:41788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T22:48:39.372882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.986215ms","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-04-16T22:48:39.37293Z","caller":"traceutil/trace.go:171","msg":"trace[57258679] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:584; }","duration":"459.050737ms","start":"2026-04-16T22:48:38.913864Z","end":"2026-04-16T22:48:39.372915Z","steps":["trace[57258679] 'agreement among raft nodes before linearized reading' (duration: 458.940144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:48:39.372959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:48:38.913791Z","time spent":"459.16071ms","remote":"127.0.0.1:41772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-16T22:48:54.535151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.991668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T22:48:54.535333Z","caller":"traceutil/trace.go:171","msg":"trace[1930894797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:737; }","duration":"114.240124ms","start":"2026-04-16T22:48:54.421062Z","end":"2026-04-16T22:48:54.535302Z","steps":["trace[1930894797] 'range keys from in-memory index tree' (duration: 113.886866ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:09.822318Z","caller":"traceutil/trace.go:171","msg":"trace[704273335] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"111.024854ms","start":"2026-04-16T22:49:09.711263Z","end":"2026-04-16T22:49:09.822287Z","steps":["trace[704273335] 'process raft request' (duration: 77.78823ms)","trace[704273335] 'compare' (duration: 32.923987ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:49:09.822432Z","caller":"traceutil/trace.go:171","msg":"trace[1426740269] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"110.934471ms","start":"2026-04-16T22:49:09.711467Z","end":"2026-04-16T22:49:09.822401Z","steps":["trace[1426740269] 'process raft request' (duration: 110.698005ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:09.822504Z","caller":"traceutil/trace.go:171","msg":"trace[830336415] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"110.793578ms","start":"2026-04-16T22:49:09.711699Z","end":"2026-04-16T22:49:09.822492Z","steps":["trace[830336415] 'process raft request' (duration: 110.624004ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:09.822598Z","caller":"traceutil/trace.go:171","msg":"trace[1796169318] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"107.009204ms","start":"2026-04-16T22:49:09.715557Z","end":"2026-04-16T22:49:09.822566Z","steps":["trace[1796169318] 'process raft request' (duration: 106.883081ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:09.822662Z","caller":"traceutil/trace.go:171","msg":"trace[1199217574] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"109.252911ms","start":"2026-04-16T22:49:09.71334Z","end":"2026-04-16T22:49:09.822592Z","steps":["trace[1199217574] 'process raft request' (duration: 109.026785ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:09.822714Z","caller":"traceutil/trace.go:171","msg":"trace[198540960] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"105.99073ms","start":"2026-04-16T22:49:09.71669Z","end":"2026-04-16T22:49:09.82268Z","steps":["trace[198540960] 'process raft request' (duration: 105.824606ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:09.884311Z","caller":"traceutil/trace.go:171","msg":"trace[1309073441] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"118.13396ms","start":"2026-04-16T22:49:09.766148Z","end":"2026-04-16T22:49:09.884282Z","steps":["trace[1309073441] 'process raft request' (duration: 117.927755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:50:09.094122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.788828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-16T22:50:09.094243Z","caller":"traceutil/trace.go:171","msg":"trace[1311807256] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1800; }","duration":"187.043134ms","start":"2026-04-16T22:50:08.907176Z","end":"2026-04-16T22:50:09.094219Z","steps":["trace[1311807256] 'range keys from in-memory index tree' (duration: 186.475501ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:50:09.290223Z","caller":"traceutil/trace.go:171","msg":"trace[1501325615] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"149.74789ms","start":"2026-04-16T22:50:09.140439Z","end":"2026-04-16T22:50:09.290187Z","steps":["trace[1501325615] 'process raft request' (duration: 131.231712ms)","trace[1501325615] 'compare' (duration: 18.343034ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:50:09.327831Z","caller":"traceutil/trace.go:171","msg":"trace[761454153] linearizableReadLoop","detail":"{readStateIndex:1874; appliedIndex:1872; }","duration":"138.840096ms","start":"2026-04-16T22:50:09.188961Z","end":"2026-04-16T22:50:09.327801Z","steps":["trace[761454153] 'read index received' (duration: 82.710576ms)","trace[761454153] 'applied index is now lower than readState.Index' (duration: 56.12803ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:50:09.327924Z","caller":"traceutil/trace.go:171","msg":"trace[1567061627] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"176.547629ms","start":"2026-04-16T22:50:09.151336Z","end":"2026-04-16T22:50:09.327884Z","steps":["trace[1567061627] 'process raft request' (duration: 176.316434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:50:09.327974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.9971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b504a792-1438-4027-82c5-58ff28c90241\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-04-16T22:50:09.328168Z","caller":"traceutil/trace.go:171","msg":"trace[444331314] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b504a792-1438-4027-82c5-58ff28c90241; range_end:; response_count:1; response_revision:1805; }","duration":"139.198485ms","start":"2026-04-16T22:50:09.188945Z","end":"2026-04-16T22:50:09.328143Z","steps":["trace[444331314] 'agreement among raft nodes before linearized reading' (duration: 138.964579ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:50:09.524056Z","caller":"traceutil/trace.go:171","msg":"trace[952181062] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"141.446599ms","start":"2026-04-16T22:50:09.38258Z","end":"2026-04-16T22:50:09.524026Z","steps":["trace[952181062] 'process raft request' (duration: 109.287159ms)","trace[952181062] 'compare' (duration: 32.042077ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:50:54.597573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.003417ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T22:50:54.597852Z","caller":"traceutil/trace.go:171","msg":"trace[1592341908] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"257.207228ms","start":"2026-04-16T22:50:54.340625Z","end":"2026-04-16T22:50:54.597833Z","steps":["trace[1592341908] 'process raft request' (duration: 27.847622ms)","trace[1592341908] 'compare' (duration: 228.903055ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:50:54.597966Z","caller":"traceutil/trace.go:171","msg":"trace[1261465884] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2184; }","duration":"188.800768ms","start":"2026-04-16T22:50:54.409156Z","end":"2026-04-16T22:50:54.597957Z","steps":["trace[1261465884] 'read index received' (duration: 42.221µs)","trace[1261465884] 'applied index is now lower than readState.Index' (duration: 188.757417ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:50:54.598174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.022714ms","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-04-16T22:50:54.598212Z","caller":"traceutil/trace.go:171","msg":"trace[294602022] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2106; }","duration":"189.089845ms","start":"2026-04-16T22:50:54.409111Z","end":"2026-04-16T22:50:54.598201Z","steps":["trace[294602022] 'agreement among raft nodes before linearized reading' (duration: 188.969492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:50:54.598516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.247379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T22:50:54.598681Z","caller":"traceutil/trace.go:171","msg":"trace[1529638751] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2106; }","duration":"177.458054ms","start":"2026-04-16T22:50:54.421182Z","end":"2026-04-16T22:50:54.59864Z","steps":["trace[1529638751] 'agreement among raft nodes before linearized reading' (duration: 177.161007ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:51:43.932529Z","caller":"traceutil/trace.go:171","msg":"trace[1226678252] transaction","detail":"{read_only:false; response_revision:2421; number_of_response:1; }","duration":"222.174843ms","start":"2026-04-16T22:51:43.710331Z","end":"2026-04-16T22:51:43.932506Z","steps":["trace[1226678252] 'process raft request' (duration: 222.03235ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:52:17.484662Z","caller":"traceutil/trace.go:171","msg":"trace[1758664263] transaction","detail":"{read_only:false; response_revision:2606; number_of_response:1; }","duration":"168.257039ms","start":"2026-04-16T22:52:17.316374Z","end":"2026-04-16T22:52:17.484631Z","steps":["trace[1758664263] 'process raft request' (duration: 150.982965ms)","trace[1758664263] 'compare' (duration: 16.973187ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:52:17.484661Z","caller":"traceutil/trace.go:171","msg":"trace[1702752787] linearizableReadLoop","detail":"{readStateIndex:2705; appliedIndex:2704; }","duration":"156.905154ms","start":"2026-04-16T22:52:17.327719Z","end":"2026-04-16T22:52:17.484624Z","steps":["trace[1702752787] 'read index received' (duration: 139.457435ms)","trace[1702752787] 'applied index is now lower than readState.Index' (duration: 17.445819ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:52:17.48512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.375356ms","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-16T22:52:17.485211Z","caller":"traceutil/trace.go:171","msg":"trace[1851961937] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2606; }","duration":"157.500668ms","start":"2026-04-16T22:52:17.327687Z","end":"2026-04-16T22:52:17.485187Z","steps":["trace[1851961937] 'agreement among raft nodes before linearized reading' (duration: 157.025706ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:52:17.99043Z","caller":"traceutil/trace.go:171","msg":"trace[1955030563] transaction","detail":"{read_only:false; response_revision:2608; number_of_response:1; }","duration":"174.955067ms","start":"2026-04-16T22:52:17.815458Z","end":"2026-04-16T22:52:17.990413Z","steps":["trace[1955030563] 'process raft request' (duration: 174.860064ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:52:18.001562Z","caller":"traceutil/trace.go:171","msg":"trace[2024007055] transaction","detail":"{read_only:false; response_revision:2609; number_of_response:1; }","duration":"185.192596ms","start":"2026-04-16T22:52:17.816358Z","end":"2026-04-16T22:52:18.001551Z","steps":["trace[2024007055] 'process raft request' (duration: 185.069013ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:52:18.001649Z","caller":"traceutil/trace.go:171","msg":"trace[966455298] transaction","detail":"{read_only:false; response_revision:2610; number_of_response:1; }","duration":"185.092494ms","start":"2026-04-16T22:52:17.81654Z","end":"2026-04-16T22:52:18.001632Z","steps":["trace[966455298] 'process raft request' (duration: 184.9503ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:55:04.061977Z","caller":"traceutil/trace.go:171","msg":"trace[1039974860] transaction","detail":"{read_only:false; response_revision:3670; number_of_response:1; }","duration":"143.358734ms","start":"2026-04-16T22:55:03.918553Z","end":"2026-04-16T22:55:04.061912Z","steps":["trace[1039974860] 'process raft request' (duration: 143.133899ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:56:12.907301Z","caller":"traceutil/trace.go:171","msg":"trace[1604323971] linearizableReadLoop","detail":"{readStateIndex:4683; appliedIndex:4682; }","duration":"117.113087ms","start":"2026-04-16T22:56:12.790133Z","end":"2026-04-16T22:56:12.907246Z","steps":["trace[1604323971] 'read index received' (duration: 111.048933ms)","trace[1604323971] 'applied index is now lower than readState.Index' (duration: 6.062574ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:56:12.907329Z","caller":"traceutil/trace.go:171","msg":"trace[989551435] transaction","detail":"{read_only:false; response_revision:4510; number_of_response:1; }","duration":"118.155342ms","start":"2026-04-16T22:56:12.789148Z","end":"2026-04-16T22:56:12.907303Z","steps":["trace[989551435] 'process raft request' (duration: 112.064428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:56:12.9079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.743472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:9 size:61929"} {"level":"warn","ts":"2026-04-16T22:56:12.907963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.987547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-16T22:56:12.908028Z","caller":"traceutil/trace.go:171","msg":"trace[2058211761] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4510; }","duration":"115.09089ms","start":"2026-04-16T22:56:12.792922Z","end":"2026-04-16T22:56:12.908012Z","steps":["trace[2058211761] 'agreement among raft nodes before linearized reading' (duration: 114.874195ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:56:12.907993Z","caller":"traceutil/trace.go:171","msg":"trace[442175947] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:9; response_revision:4510; }","duration":"117.868205ms","start":"2026-04-16T22:56:12.790105Z","end":"2026-04-16T22:56:12.907974Z","steps":["trace[442175947] 'agreement among raft nodes before linearized reading' (duration: 117.367993ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:56:32.180619Z","caller":"traceutil/trace.go:171","msg":"trace[1169720899] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"169.05421ms","start":"2026-04-16T22:56:32.011536Z","end":"2026-04-16T22:56:32.18059Z","steps":["trace[1169720899] 'process raft request' (duration: 91.371161ms)","trace[1169720899] 'compare' (duration: 77.482525ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:56:39.211779Z","caller":"traceutil/trace.go:171","msg":"trace[1666140157] linearizableReadLoop","detail":"{readStateIndex:5325; appliedIndex:5324; }","duration":"172.05845ms","start":"2026-04-16T22:56:39.039694Z","end":"2026-04-16T22:56:39.211753Z","steps":["trace[1666140157] 'read index received' (duration: 171.842905ms)","trace[1666140157] 'applied index is now lower than readState.Index' (duration: 214.275µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:56:39.211818Z","caller":"traceutil/trace.go:171","msg":"trace[812273339] transaction","detail":"{read_only:false; response_revision:5134; number_of_response:1; }","duration":"189.744697ms","start":"2026-04-16T22:56:39.022047Z","end":"2026-04-16T22:56:39.211792Z","steps":["trace[812273339] 'process raft request' (duration: 189.520201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:56:39.212076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.356078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wh9q6\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-16T22:56:39.212185Z","caller":"traceutil/trace.go:171","msg":"trace[1621018923] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wh9q6; range_end:; response_count:1; response_revision:5134; }","duration":"172.472891ms","start":"2026-04-16T22:56:39.039667Z","end":"2026-04-16T22:56:39.212139Z","steps":["trace[1621018923] 'agreement among raft nodes before linearized reading' (duration: 172.243096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:56:39.287665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.740515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-938a4c04-6786-4140-8a34-4def93cae27c\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-04-16T22:56:39.28775Z","caller":"traceutil/trace.go:171","msg":"trace[1071852742] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-938a4c04-6786-4140-8a34-4def93cae27c; range_end:; response_count:1; response_revision:5135; }","duration":"129.865568ms","start":"2026-04-16T22:56:39.157863Z","end":"2026-04-16T22:56:39.287728Z","steps":["trace[1071852742] 'agreement among raft nodes before linearized reading' (duration: 129.675703ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:56:39.287688Z","caller":"traceutil/trace.go:171","msg":"trace[325229528] transaction","detail":"{read_only:false; response_revision:5135; number_of_response:1; }","duration":"126.52112ms","start":"2026-04-16T22:56:39.161128Z","end":"2026-04-16T22:56:39.287649Z","steps":["trace[325229528] 'process raft request' (duration: 126.16274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:56:39.287839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.12363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T22:56:39.28803Z","caller":"traceutil/trace.go:171","msg":"trace[1069305015] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:5135; }","duration":"115.300964ms","start":"2026-04-16T22:56:39.172655Z","end":"2026-04-16T22:56:39.287956Z","steps":["trace[1069305015] 'agreement among raft nodes before linearized reading' (duration: 115.087129ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:56:39.436753Z","caller":"traceutil/trace.go:171","msg":"trace[669684951] transaction","detail":"{read_only:false; response_revision:5136; number_of_response:1; }","duration":"140.140169ms","start":"2026-04-16T22:56:39.296577Z","end":"2026-04-16T22:56:39.436718Z","steps":["trace[669684951] 'process raft request' (duration: 139.894983ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:57:36.323153Z","caller":"traceutil/trace.go:171","msg":"trace[144457715] transaction","detail":"{read_only:false; response_revision:5720; number_of_response:1; }","duration":"107.358807ms","start":"2026-04-16T22:57:36.215758Z","end":"2026-04-16T22:57:36.323117Z","steps":["trace[144457715] 'process raft request' (duration: 107.176663ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:02.718688Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2844} {"level":"info","ts":"2026-04-16T22:58:02.791669Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2844,"took":"71.101775ms","hash":515993550,"current-db-size-bytes":57810944,"current-db-size":"58 MB","current-db-size-in-use-bytes":32702464,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-16T22:58:02.791748Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":515993550,"revision":2844,"compact-revision":-1} {"level":"warn","ts":"2026-04-16T23:02:35.519229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.365066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T23:02:35.519431Z","caller":"traceutil/trace.go:171","msg":"trace[835198178] transaction","detail":"{read_only:false; response_revision:7963; number_of_response:1; }","duration":"188.136322ms","start":"2026-04-16T23:02:35.331277Z","end":"2026-04-16T23:02:35.519413Z","steps":["trace[835198178] 'process raft request' (duration: 188.082221ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:02:35.5194Z","caller":"traceutil/trace.go:171","msg":"trace[1244803732] transaction","detail":"{read_only:false; response_revision:7962; number_of_response:1; }","duration":"363.791692ms","start":"2026-04-16T23:02:35.155576Z","end":"2026-04-16T23:02:35.519367Z","steps":["trace[1244803732] 'process raft request' (duration: 241.18497ms)","trace[1244803732] 'compare' (duration: 122.244894ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:02:35.519439Z","caller":"traceutil/trace.go:171","msg":"trace[783808691] linearizableReadLoop","detail":"{readStateIndex:8241; appliedIndex:8240; }","duration":"360.396942ms","start":"2026-04-16T23:02:35.159005Z","end":"2026-04-16T23:02:35.519402Z","steps":["trace[783808691] 'read index received' (duration: 237.766199ms)","trace[783808691] 'applied index is now lower than readState.Index' (duration: 122.628243ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:02:35.519569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:02:35.155559Z","time spent":"363.925885ms","remote":"127.0.0.1:41788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T23:02:35.519712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.90189ms","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":"warn","ts":"2026-04-16T23:02:35.519696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.667688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wh9q6\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-16T23:02:35.519748Z","caller":"traceutil/trace.go:171","msg":"trace[1463341442] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7963; }","duration":"359.967112ms","start":"2026-04-16T23:02:35.159771Z","end":"2026-04-16T23:02:35.519738Z","steps":["trace[1463341442] 'agreement among raft nodes before linearized reading' (duration: 359.790267ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:02:35.51977Z","caller":"traceutil/trace.go:171","msg":"trace[191277023] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wh9q6; range_end:; response_count:1; response_revision:7963; }","duration":"360.7538ms","start":"2026-04-16T23:02:35.158999Z","end":"2026-04-16T23:02:35.519752Z","steps":["trace[191277023] 'agreement among raft nodes before linearized reading' (duration: 360.545625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:02:35.519785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:02:35.159763Z","time spent":"360.013423ms","remote":"127.0.0.1:41788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T23:02:35.519819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:02:35.158941Z","time spent":"360.868843ms","remote":"127.0.0.1:41706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-wh9q6\" "} {"level":"warn","ts":"2026-04-16T23:02:35.51985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.062592ms","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-04-16T23:02:35.519896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.317067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T23:02:35.519936Z","caller":"traceutil/trace.go:171","msg":"trace[419084922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7963; }","duration":"345.155384ms","start":"2026-04-16T23:02:35.174757Z","end":"2026-04-16T23:02:35.519912Z","steps":["trace[419084922] 'agreement among raft nodes before linearized reading' (duration: 344.897298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:02:35.519985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:02:35.174698Z","time spent":"345.277336ms","remote":"127.0.0.1:41788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-16T23:02:35.519983Z","caller":"traceutil/trace.go:171","msg":"trace[800642125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7963; }","duration":"348.43884ms","start":"2026-04-16T23:02:35.171522Z","end":"2026-04-16T23:02:35.519961Z","steps":["trace[800642125] 'agreement among raft nodes before linearized reading' (duration: 348.151473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:02:35.520035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:02:35.171512Z","time spent":"348.514862ms","remote":"127.0.0.1:41788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T23:02:47.34782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.310393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T23:02:47.347956Z","caller":"traceutil/trace.go:171","msg":"trace[547470221] transaction","detail":"{read_only:false; response_revision:8026; number_of_response:1; }","duration":"426.243239ms","start":"2026-04-16T23:02:46.921684Z","end":"2026-04-16T23:02:47.347927Z","steps":["trace[547470221] 'process raft request' (duration: 104.68119ms)","trace[547470221] 'compare' (duration: 321.079718ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:02:47.348032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:02:46.921649Z","time spent":"426.343962ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19339,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T23:02:47.378553Z","caller":"traceutil/trace.go:171","msg":"trace[661940955] transaction","detail":"{read_only:false; response_revision:8027; number_of_response:1; }","duration":"265.279356ms","start":"2026-04-16T23:02:47.113249Z","end":"2026-04-16T23:02:47.378528Z","steps":["trace[661940955] 'process raft request' (duration: 264.966568ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:02:48.499901Z","caller":"traceutil/trace.go:171","msg":"trace[1052905142] transaction","detail":"{read_only:false; response_revision:8035; number_of_response:1; }","duration":"166.901103ms","start":"2026-04-16T23:02:48.332962Z","end":"2026-04-16T23:02:48.499863Z","steps":["trace[1052905142] 'process raft request' (duration: 166.625237ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:02.724922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5888} {"level":"info","ts":"2026-04-16T23:03:02.808794Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5888,"took":"81.875575ms","hash":235161852,"current-db-size-bytes":57810944,"current-db-size":"58 MB","current-db-size-in-use-bytes":26685440,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-04-16T23:03:02.808868Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":235161852,"revision":5888,"compact-revision":2844} {"level":"info","ts":"2026-04-16T23:03:14.783284Z","caller":"traceutil/trace.go:171","msg":"trace[649989287] transaction","detail":"{read_only:false; response_revision:8226; number_of_response:1; }","duration":"161.65533ms","start":"2026-04-16T23:03:14.621608Z","end":"2026-04-16T23:03:14.783263Z","steps":["trace[649989287] 'process raft request' (duration: 161.523847ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:28.113289Z","caller":"traceutil/trace.go:171","msg":"trace[637049535] transaction","detail":"{read_only:false; response_revision:8337; number_of_response:1; }","duration":"352.2582ms","start":"2026-04-16T23:03:27.761Z","end":"2026-04-16T23:03:28.113258Z","steps":["trace[637049535] 'process raft request' (duration: 352.077006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:28.113471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:03:27.760967Z","time spent":"352.417004ms","remote":"127.0.0.1:41772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T23:03:28.157897Z","caller":"traceutil/trace.go:171","msg":"trace[733320582] linearizableReadLoop","detail":"{readStateIndex:8634; appliedIndex:8632; }","duration":"219.253123ms","start":"2026-04-16T23:03:27.93862Z","end":"2026-04-16T23:03:28.157873Z","steps":["trace[733320582] 'read index received' (duration: 174.487571ms)","trace[733320582] 'applied index is now lower than readState.Index' (duration: 44.764312ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:03:28.15795Z","caller":"traceutil/trace.go:171","msg":"trace[2016094185] transaction","detail":"{read_only:false; response_revision:8338; number_of_response:1; }","duration":"361.056178ms","start":"2026-04-16T23:03:27.79685Z","end":"2026-04-16T23:03:28.157907Z","steps":["trace[2016094185] 'process raft request' (duration: 360.884104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:28.158096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:03:27.796817Z","time spent":"361.212361ms","remote":"127.0.0.1:41788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T23:03:28.158117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.478709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-16T23:03:28.158153Z","caller":"traceutil/trace.go:171","msg":"trace[169408706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8338; }","duration":"219.55791ms","start":"2026-04-16T23:03:27.938583Z","end":"2026-04-16T23:03:28.158141Z","steps":["trace[169408706] 'agreement among raft nodes before linearized reading' (duration: 219.415637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:28.15817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.432981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-16T23:03:28.158269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.859725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-16T23:03:28.158321Z","caller":"traceutil/trace.go:171","msg":"trace[738961227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8338; }","duration":"204.922177ms","start":"2026-04-16T23:03:27.953384Z","end":"2026-04-16T23:03:28.158306Z","steps":["trace[738961227] 'agreement among raft nodes before linearized reading' (duration: 204.830025ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:28.15826Z","caller":"traceutil/trace.go:171","msg":"trace[990701220] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8338; }","duration":"200.535264ms","start":"2026-04-16T23:03:27.9577Z","end":"2026-04-16T23:03:28.158235Z","steps":["trace[990701220] 'agreement among raft nodes before linearized reading' (duration: 200.353249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:28.158179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.701561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-16T23:03:28.158387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.604536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wh9q6\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-16T23:03:28.158421Z","caller":"traceutil/trace.go:171","msg":"trace[1803286298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8338; }","duration":"218.968607ms","start":"2026-04-16T23:03:27.939443Z","end":"2026-04-16T23:03:28.158412Z","steps":["trace[1803286298] 'agreement among raft nodes before linearized reading' (duration: 218.601488ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:28.158429Z","caller":"traceutil/trace.go:171","msg":"trace[1358783157] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wh9q6; range_end:; response_count:1; response_revision:8338; }","duration":"186.668367ms","start":"2026-04-16T23:03:27.97175Z","end":"2026-04-16T23:03:28.158418Z","steps":["trace[1358783157] 'agreement among raft nodes before linearized reading' (duration: 186.547864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:28.158279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.016508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-04-16T23:03:28.158544Z","caller":"traceutil/trace.go:171","msg":"trace[2115476351] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8338; }","duration":"202.333886ms","start":"2026-04-16T23:03:27.956203Z","end":"2026-04-16T23:03:28.158537Z","steps":["trace[2115476351] 'agreement among raft nodes before linearized reading' (duration: 201.979217ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:28.280179Z","caller":"traceutil/trace.go:171","msg":"trace[1945605381] transaction","detail":"{read_only:false; response_revision:8340; number_of_response:1; }","duration":"116.168021ms","start":"2026-04-16T23:03:28.163978Z","end":"2026-04-16T23:03:28.280146Z","steps":["trace[1945605381] 'process raft request' (duration: 76.839706ms)","trace[1945605381] 'compare' (duration: 38.942506ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:03:28.280475Z","caller":"traceutil/trace.go:171","msg":"trace[2073904616] transaction","detail":"{read_only:false; response_revision:8343; number_of_response:1; }","duration":"116.183201ms","start":"2026-04-16T23:03:28.164276Z","end":"2026-04-16T23:03:28.280459Z","steps":["trace[2073904616] 'process raft request' (duration: 116.143391ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:28.280602Z","caller":"traceutil/trace.go:171","msg":"trace[1891806565] transaction","detail":"{read_only:false; response_revision:8342; number_of_response:1; }","duration":"116.380226ms","start":"2026-04-16T23:03:28.16421Z","end":"2026-04-16T23:03:28.28059Z","steps":["trace[1891806565] 'process raft request' (duration: 116.139501ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:28.280672Z","caller":"traceutil/trace.go:171","msg":"trace[752303846] transaction","detail":"{read_only:false; response_revision:8341; number_of_response:1; }","duration":"116.438318ms","start":"2026-04-16T23:03:28.164199Z","end":"2026-04-16T23:03:28.280637Z","steps":["trace[752303846] 'process raft request' (duration: 115.861834ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:29.203842Z","caller":"traceutil/trace.go:171","msg":"trace[620106718] linearizableReadLoop","detail":"{readStateIndex:8643; appliedIndex:8641; }","duration":"224.535788ms","start":"2026-04-16T23:03:28.979265Z","end":"2026-04-16T23:03:29.203801Z","steps":["trace[620106718] 'read index received' (duration: 7.136659ms)","trace[620106718] 'applied index is now lower than readState.Index' (duration: 217.398049ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:03:29.203878Z","caller":"traceutil/trace.go:171","msg":"trace[1944518260] transaction","detail":"{read_only:false; response_revision:8347; number_of_response:1; }","duration":"256.722374ms","start":"2026-04-16T23:03:28.947121Z","end":"2026-04-16T23:03:29.203843Z","steps":["trace[1944518260] 'process raft request' (duration: 256.52669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:29.204038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.748293ms","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-16T23:03:29.204133Z","caller":"traceutil/trace.go:171","msg":"trace[778088101] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8347; }","duration":"224.884977ms","start":"2026-04-16T23:03:28.979227Z","end":"2026-04-16T23:03:29.204112Z","steps":["trace[778088101] 'agreement among raft nodes before linearized reading' (duration: 224.724403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:29.618295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.962707ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T23:03:29.618409Z","caller":"traceutil/trace.go:171","msg":"trace[508948215] linearizableReadLoop","detail":"{readStateIndex:8644; appliedIndex:8643; }","duration":"407.680613ms","start":"2026-04-16T23:03:29.210711Z","end":"2026-04-16T23:03:29.618392Z","steps":["trace[508948215] 'read index received' (duration: 305.567143ms)","trace[508948215] 'applied index is now lower than readState.Index' (duration: 102.11188ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:03:29.618611Z","caller":"traceutil/trace.go:171","msg":"trace[265187855] transaction","detail":"{read_only:false; response_revision:8348; number_of_response:1; }","duration":"410.267004ms","start":"2026-04-16T23:03:29.208198Z","end":"2026-04-16T23:03:29.618465Z","steps":["trace[265187855] 'process raft request' (duration: 308.050981ms)","trace[265187855] 'compare' (duration: 101.611529ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:03:29.618729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.9963ms","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-16T23:03:29.618817Z","caller":"traceutil/trace.go:171","msg":"trace[910015238] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8348; }","duration":"408.107232ms","start":"2026-04-16T23:03:29.210692Z","end":"2026-04-16T23:03:29.618799Z","steps":["trace[910015238] 'agreement among raft nodes before linearized reading' (duration: 407.766434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:29.618869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:03:29.210682Z","time spent":"408.177395ms","remote":"127.0.0.1:41706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-16T23:03:29.619141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:03:29.208174Z","time spent":"410.541749ms","remote":"127.0.0.1:41788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T23:03:29.636526Z","caller":"traceutil/trace.go:171","msg":"trace[755305085] transaction","detail":"{read_only:false; response_revision:8349; number_of_response:1; }","duration":"103.275988ms","start":"2026-04-16T23:03:29.533213Z","end":"2026-04-16T23:03:29.636489Z","steps":["trace[755305085] 'process raft request' (duration: 103.074984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:29.636903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.354452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T23:03:29.636985Z","caller":"traceutil/trace.go:171","msg":"trace[914293350] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:8349; }","duration":"229.496705ms","start":"2026-04-16T23:03:29.407468Z","end":"2026-04-16T23:03:29.636964Z","steps":["trace[914293350] 'agreement among raft nodes before linearized reading' (duration: 229.229909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:29.637368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.167513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-16T23:03:29.63753Z","caller":"traceutil/trace.go:171","msg":"trace[622609170] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8349; }","duration":"208.366368ms","start":"2026-04-16T23:03:29.429118Z","end":"2026-04-16T23:03:29.637485Z","steps":["trace[622609170] 'agreement among raft nodes before linearized reading' (duration: 207.397156ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:30.334203Z","caller":"traceutil/trace.go:171","msg":"trace[938875585] linearizableReadLoop","detail":"{readStateIndex:8647; appliedIndex:8646; }","duration":"165.380968ms","start":"2026-04-16T23:03:30.168799Z","end":"2026-04-16T23:03:30.33418Z","steps":["trace[938875585] 'read index received' (duration: 165.068851ms)","trace[938875585] 'applied index is now lower than readState.Index' (duration: 310.507µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:03:30.334312Z","caller":"traceutil/trace.go:171","msg":"trace[1726661142] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"170.010626ms","start":"2026-04-16T23:03:30.164278Z","end":"2026-04-16T23:03:30.334288Z","steps":["trace[1726661142] 'process raft request' (duration: 169.618347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:30.334437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.050299ms","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-04-16T23:03:30.33447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.666614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wh9q6\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-16T23:03:30.334551Z","caller":"traceutil/trace.go:171","msg":"trace[742804193] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wh9q6; range_end:; response_count:1; response_revision:8351; }","duration":"165.773976ms","start":"2026-04-16T23:03:30.168763Z","end":"2026-04-16T23:03:30.334537Z","steps":["trace[742804193] 'agreement among raft nodes before linearized reading' (duration: 165.546151ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:30.334499Z","caller":"traceutil/trace.go:171","msg":"trace[1209517353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8351; }","duration":"159.153461ms","start":"2026-04-16T23:03:30.175331Z","end":"2026-04-16T23:03:30.334485Z","steps":["trace[1209517353] 'agreement among raft nodes before linearized reading' (duration: 158.991857ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:30.495174Z","caller":"traceutil/trace.go:171","msg":"trace[1066659688] transaction","detail":"{read_only:false; response_revision:8352; number_of_response:1; }","duration":"156.684123ms","start":"2026-04-16T23:03:30.338468Z","end":"2026-04-16T23:03:30.495152Z","steps":["trace[1066659688] 'process raft request' (duration: 146.500625ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:30.495609Z","caller":"traceutil/trace.go:171","msg":"trace[1709946278] transaction","detail":"{read_only:false; response_revision:8353; number_of_response:1; }","duration":"156.59409ms","start":"2026-04-16T23:03:30.338975Z","end":"2026-04-16T23:03:30.495569Z","steps":["trace[1709946278] 'process raft request' (duration: 156.131249ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:30.495712Z","caller":"traceutil/trace.go:171","msg":"trace[367958187] transaction","detail":"{read_only:false; response_revision:8354; number_of_response:1; }","duration":"156.649453ms","start":"2026-04-16T23:03:30.339036Z","end":"2026-04-16T23:03:30.495685Z","steps":["trace[367958187] 'process raft request' (duration: 156.350345ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:30.496002Z","caller":"traceutil/trace.go:171","msg":"trace[245430710] linearizableReadLoop","detail":"{readStateIndex:8652; appliedIndex:8647; }","duration":"156.293514ms","start":"2026-04-16T23:03:30.339693Z","end":"2026-04-16T23:03:30.495987Z","steps":["trace[245430710] 'read index received' (duration: 145.272565ms)","trace[245430710] 'applied index is now lower than readState.Index' (duration: 11.019919ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:03:30.496108Z","caller":"traceutil/trace.go:171","msg":"trace[669160776] transaction","detail":"{read_only:false; response_revision:8356; number_of_response:1; }","duration":"156.55302ms","start":"2026-04-16T23:03:30.339544Z","end":"2026-04-16T23:03:30.496097Z","steps":["trace[669160776] 'process raft request' (duration: 156.397367ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:30.496092Z","caller":"traceutil/trace.go:171","msg":"trace[1264063980] transaction","detail":"{read_only:false; response_revision:8355; number_of_response:1; }","duration":"156.963209ms","start":"2026-04-16T23:03:30.339053Z","end":"2026-04-16T23:03:30.496017Z","steps":["trace[1264063980] 'process raft request' (duration: 156.833156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:30.496515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.808176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:211681"} {"level":"info","ts":"2026-04-16T23:03:30.496646Z","caller":"traceutil/trace.go:171","msg":"trace[431466564] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8356; }","duration":"156.94942ms","start":"2026-04-16T23:03:30.339681Z","end":"2026-04-16T23:03:30.496631Z","steps":["trace[431466564] 'agreement among raft nodes before linearized reading' (duration: 156.500849ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:12.889804Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023a4.wal"} {"level":"info","ts":"2026-04-16T23:04:36.962862Z","caller":"traceutil/trace.go:171","msg":"trace[757603591] transaction","detail":"{read_only:false; response_revision:8984; number_of_response:1; }","duration":"135.837971ms","start":"2026-04-16T23:04:36.826999Z","end":"2026-04-16T23:04:36.962837Z","steps":["trace[757603591] 'process raft request' (duration: 135.690967ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:37.127557Z","caller":"traceutil/trace.go:171","msg":"trace[463875004] transaction","detail":"{read_only:false; response_revision:8985; number_of_response:1; }","duration":"299.052208ms","start":"2026-04-16T23:04:36.828483Z","end":"2026-04-16T23:04:37.127536Z","steps":["trace[463875004] 'process raft request' (duration: 278.304867ms)","trace[463875004] 'compare' (duration: 20.618188ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:04:37.12776Z","caller":"traceutil/trace.go:171","msg":"trace[1851017162] transaction","detail":"{read_only:false; response_revision:8986; number_of_response:1; }","duration":"297.788189ms","start":"2026-04-16T23:04:36.829955Z","end":"2026-04-16T23:04:37.127743Z","steps":["trace[1851017162] 'process raft request' (duration: 297.547293ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:37.128005Z","caller":"traceutil/trace.go:171","msg":"trace[1460986221] transaction","detail":"{read_only:false; response_revision:8987; number_of_response:1; }","duration":"297.943172ms","start":"2026-04-16T23:04:36.83005Z","end":"2026-04-16T23:04:37.127993Z","steps":["trace[1460986221] 'process raft request' (duration: 297.617155ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:37.12799Z","caller":"traceutil/trace.go:171","msg":"trace[225520424] linearizableReadLoop","detail":"{readStateIndex:9303; appliedIndex:9299; }","duration":"267.467175ms","start":"2026-04-16T23:04:36.860503Z","end":"2026-04-16T23:04:37.12797Z","steps":["trace[225520424] 'read index received' (duration: 102.511338ms)","trace[225520424] 'applied index is now lower than readState.Index' (duration: 164.955147ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:04:37.128054Z","caller":"traceutil/trace.go:171","msg":"trace[370474488] transaction","detail":"{read_only:false; response_revision:8988; number_of_response:1; }","duration":"297.329348ms","start":"2026-04-16T23:04:36.830689Z","end":"2026-04-16T23:04:37.128019Z","steps":["trace[370474488] 'process raft request' (duration: 297.221445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:37.128229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.7128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wh9q6\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-16T23:04:37.128268Z","caller":"traceutil/trace.go:171","msg":"trace[820267100] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wh9q6; range_end:; response_count:1; response_revision:8988; }","duration":"267.789902ms","start":"2026-04-16T23:04:36.860469Z","end":"2026-04-16T23:04:37.128259Z","steps":["trace[820267100] 'agreement among raft nodes before linearized reading' (duration: 267.619558ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:57.822464Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5f170c75a1d97cc","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-16T23:05:57.828522Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-16T23:05:57.82863Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-16T23:08:02.73213Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8113} {"level":"info","ts":"2026-04-16T23:08:02.797389Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8113,"took":"63.056906ms","hash":2619825465,"current-db-size-bytes":57810944,"current-db-size":"58 MB","current-db-size-in-use-bytes":28946432,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-16T23:08:02.797458Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2619825465,"revision":8113,"compact-revision":5888} {"level":"info","ts":"2026-04-16T23:13:02.736981Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10547} {"level":"info","ts":"2026-04-16T23:13:02.816639Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10547,"took":"78.113102ms","hash":2549119087,"current-db-size-bytes":57810944,"current-db-size":"58 MB","current-db-size-in-use-bytes":19984384,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-16T23:13:02.8167Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2549119087,"revision":10547,"compact-revision":8113}