{"level":"warn","ts":"2026-04-20T04:52:12.420761Z","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-20T04:52:12.420841Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-20T04:52:12.420902Z","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-20T04:52:12.42091Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-04-20T04:52:12.42093Z","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-20T04:52:12.421529Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-04-20T04:52:12.421608Z","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.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-20T04:52:12.426163Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.341421ms"} {"level":"info","ts":"2026-04-20T04:52:12.441125Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-04-20T04:52:12.441238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T04:52:12.441266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-04-20T04:52:12.441284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T04:52:12.441318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-04-20T04:52:12.441379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-04-20T04:52:12.450365Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T04:52:12.451637Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T04:52:12.453017Z","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-20T04:52:12.45527Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T04:52:12.455473Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T04:52:12.455578Z","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-20T04:52:12.455659Z","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-20T04:52:12.455682Z","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-20T04:52:12.457044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-04-20T04:52:12.457257Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-04-20T04:52:12.459124Z","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-20T04:52:12.459197Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-04-20T04:52:12.45923Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-04-20T04:52:12.460759Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T04:52:12.460797Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T04:52:12.74197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T04:52:12.742041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T04:52:12.742064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-04-20T04:52:12.742084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-04-20T04:52:12.742095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-04-20T04:52:12.742131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-04-20T04:52:12.742144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-04-20T04:52:12.7431Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T04:52:12.743156Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:52:12.743125Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:52:12.743132Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:52:12.743472Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T04:52:12.743549Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T04:52:12.744325Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:52:12.744424Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:52:12.744471Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:52:12.745259Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-04-20T04:52:12.746388Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T04:52:29.256133Z","caller":"traceutil/trace.go:171","msg":"trace[1062948160] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"192.907449ms","start":"2026-04-20T04:52:29.063199Z","end":"2026-04-20T04:52:29.256106Z","steps":["trace[1062948160] 'process raft request' (duration: 192.739355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:29.51668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.689086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4378"} {"level":"info","ts":"2026-04-20T04:52:29.516801Z","caller":"traceutil/trace.go:171","msg":"trace[796333103] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:370; }","duration":"193.856159ms","start":"2026-04-20T04:52:29.322923Z","end":"2026-04-20T04:52:29.516779Z","steps":["trace[796333103] 'range keys from in-memory index tree' (duration: 193.589374ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:43.813586Z","caller":"traceutil/trace.go:171","msg":"trace[1404688218] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"179.673643ms","start":"2026-04-20T04:52:43.63387Z","end":"2026-04-20T04:52:43.813543Z","steps":["trace[1404688218] 'process raft request' (duration: 179.400567ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:43.828571Z","caller":"traceutil/trace.go:171","msg":"trace[314777424] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"149.802839ms","start":"2026-04-20T04:52:43.678738Z","end":"2026-04-20T04:52:43.828541Z","steps":["trace[314777424] 'process raft request' (duration: 149.727087ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:43.828601Z","caller":"traceutil/trace.go:171","msg":"trace[1610285818] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"190.05541ms","start":"2026-04-20T04:52:43.638506Z","end":"2026-04-20T04:52:43.828562Z","steps":["trace[1610285818] 'process raft request' (duration: 189.675862ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:49.857208Z","caller":"traceutil/trace.go:171","msg":"trace[463556691] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"143.701032ms","start":"2026-04-20T04:52:49.713475Z","end":"2026-04-20T04:52:49.857176Z","steps":["trace[463556691] 'process raft request' (duration: 143.12081ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:50.025128Z","caller":"traceutil/trace.go:171","msg":"trace[925346303] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"107.272466ms","start":"2026-04-20T04:52:49.917812Z","end":"2026-04-20T04:52:50.025085Z","steps":["trace[925346303] 'process raft request' (duration: 103.820305ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:50.058905Z","caller":"traceutil/trace.go:171","msg":"trace[834538495] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"137.803751ms","start":"2026-04-20T04:52:49.921028Z","end":"2026-04-20T04:52:50.058832Z","steps":["trace[834538495] 'process raft request' (duration: 137.572156ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:50.918313Z","caller":"traceutil/trace.go:171","msg":"trace[153520840] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"401.321045ms","start":"2026-04-20T04:52:50.516951Z","end":"2026-04-20T04:52:50.918272Z","steps":["trace[153520840] 'read index received' (duration: 399.953618ms)","trace[153520840] 'applied index is now lower than readState.Index' (duration: 1.365687ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:52:50.918512Z","caller":"traceutil/trace.go:171","msg":"trace[189044530] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"469.172814ms","start":"2026-04-20T04:52:50.449187Z","end":"2026-04-20T04:52:50.91836Z","steps":["trace[189044530] 'process raft request' (duration: 468.039291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:50.918673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.688663ms","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-20T04:52:50.918732Z","caller":"traceutil/trace.go:171","msg":"trace[1290551611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:579; }","duration":"401.829766ms","start":"2026-04-20T04:52:50.516884Z","end":"2026-04-20T04:52:50.918713Z","steps":["trace[1290551611] 'agreement among raft nodes before linearized reading' (duration: 401.602221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:50.918755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.372997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-20T04:52:50.918795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:50.516854Z","time spent":"401.928007ms","remote":"127.0.0.1:36704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T04:52:50.918864Z","caller":"traceutil/trace.go:171","msg":"trace[774316803] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:579; }","duration":"146.526259ms","start":"2026-04-20T04:52:50.772293Z","end":"2026-04-20T04:52:50.918819Z","steps":["trace[774316803] 'agreement among raft nodes before linearized reading' (duration: 146.244744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:50.919597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:50.449149Z","time spent":"469.47692ms","remote":"127.0.0.1:36522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:52:51.105576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.041828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:52:51.105671Z","caller":"traceutil/trace.go:171","msg":"trace[903876364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"185.218401ms","start":"2026-04-20T04:52:50.920431Z","end":"2026-04-20T04:52:51.105649Z","steps":["trace[903876364] 'range keys from in-memory index tree' (duration: 184.913015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:51.105902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.316555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:52:51.106058Z","caller":"traceutil/trace.go:171","msg":"trace[491860445] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"121.019787ms","start":"2026-04-20T04:52:50.98503Z","end":"2026-04-20T04:52:51.106049Z","steps":["trace[491860445] 'process raft request' (duration: 120.975206ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:51.106143Z","caller":"traceutil/trace.go:171","msg":"trace[444639081] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"182.773352ms","start":"2026-04-20T04:52:50.92335Z","end":"2026-04-20T04:52:51.106124Z","steps":["trace[444639081] 'process raft request' (duration: 18.056129ms)","trace[444639081] 'compare' (duration: 164.172372ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:52:51.10619Z","caller":"traceutil/trace.go:171","msg":"trace[587765008] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"181.823953ms","start":"2026-04-20T04:52:50.924357Z","end":"2026-04-20T04:52:51.106181Z","steps":["trace[587765008] 'process raft request' (duration: 181.606248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:25.813117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.223351ms","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-20T04:54:25.81325Z","caller":"traceutil/trace.go:171","msg":"trace[723713410] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1808; }","duration":"203.442635ms","start":"2026-04-20T04:54:25.609781Z","end":"2026-04-20T04:54:25.813223Z","steps":["trace[723713410] 'count revisions from in-memory index tree' (duration: 203.028077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:25.81355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.66755ms","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-20T04:54:25.813698Z","caller":"traceutil/trace.go:171","msg":"trace[1887517524] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1808; }","duration":"175.822613ms","start":"2026-04-20T04:54:25.637846Z","end":"2026-04-20T04:54:25.813668Z","steps":["trace[1887517524] 'range keys from in-memory index tree' (duration: 175.385964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:25.813565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.658619ms","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":"warn","ts":"2026-04-20T04:54:25.813731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.237813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-20T04:54:25.813857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.26055ms","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-20T04:54:25.813964Z","caller":"traceutil/trace.go:171","msg":"trace[1470207859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1808; }","duration":"228.446734ms","start":"2026-04-20T04:54:25.585493Z","end":"2026-04-20T04:54:25.81394Z","steps":["trace[1470207859] 'range keys from in-memory index tree' (duration: 228.016185ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:54:25.813955Z","caller":"traceutil/trace.go:171","msg":"trace[965527814] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1808; }","duration":"151.489159ms","start":"2026-04-20T04:54:25.662414Z","end":"2026-04-20T04:54:25.813903Z","steps":["trace[965527814] 'range keys from in-memory index tree' (duration: 150.936688ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:54:25.813809Z","caller":"traceutil/trace.go:171","msg":"trace[1178014858] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1808; }","duration":"233.972606ms","start":"2026-04-20T04:54:25.579822Z","end":"2026-04-20T04:54:25.813795Z","steps":["trace[1178014858] 'count revisions from in-memory index tree' (duration: 233.553317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:26.221559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.211497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-75ae569a-ef60-49d3-a4c4-4822a192e363\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-20T04:54:26.221666Z","caller":"traceutil/trace.go:171","msg":"trace[672598747] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-75ae569a-ef60-49d3-a4c4-4822a192e363; range_end:; response_count:1; response_revision:1812; }","duration":"164.34486ms","start":"2026-04-20T04:54:26.057296Z","end":"2026-04-20T04:54:26.22164Z","steps":["trace[672598747] 'range keys from in-memory index tree' (duration: 163.972072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:55:09.256792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.650875ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:55:09.256979Z","caller":"traceutil/trace.go:171","msg":"trace[937814034] linearizableReadLoop","detail":"{readStateIndex:2181; appliedIndex:2180; }","duration":"132.32978ms","start":"2026-04-20T04:55:09.124605Z","end":"2026-04-20T04:55:09.256935Z","steps":["trace[937814034] 'read index received' (duration: 2.412899ms)","trace[937814034] 'applied index is now lower than readState.Index' (duration: 129.915141ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:55:09.257247Z","caller":"traceutil/trace.go:171","msg":"trace[781932024] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"260.542036ms","start":"2026-04-20T04:55:08.996638Z","end":"2026-04-20T04:55:09.25718Z","steps":["trace[781932024] 'process raft request' (duration: 130.37796ms)","trace[781932024] 'compare' (duration: 129.315818ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:55:09.25753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.024451ms","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":"warn","ts":"2026-04-20T04:55:09.257623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.999313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-20T04:55:09.257655Z","caller":"traceutil/trace.go:171","msg":"trace[182304005] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2101; }","duration":"123.208874ms","start":"2026-04-20T04:55:09.13442Z","end":"2026-04-20T04:55:09.257629Z","steps":["trace[182304005] 'agreement among raft nodes before linearized reading' (duration: 122.841646ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:55:09.257691Z","caller":"traceutil/trace.go:171","msg":"trace[2066882728] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2101; }","duration":"133.111206ms","start":"2026-04-20T04:55:09.124561Z","end":"2026-04-20T04:55:09.257672Z","steps":["trace[2066882728] 'agreement among raft nodes before linearized reading' (duration: 132.8279ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:55:15.269477Z","caller":"traceutil/trace.go:171","msg":"trace[521144019] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"253.642806ms","start":"2026-04-20T04:55:15.015799Z","end":"2026-04-20T04:55:15.269442Z","steps":["trace[521144019] 'process raft request' (duration: 253.454402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:55:15.445148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.383349ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:55:15.445305Z","caller":"traceutil/trace.go:171","msg":"trace[404280108] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2212; }","duration":"147.454377ms","start":"2026-04-20T04:55:15.297819Z","end":"2026-04-20T04:55:15.445273Z","steps":["trace[404280108] 'read index received' (duration: 22.64235ms)","trace[404280108] 'applied index is now lower than readState.Index' (duration: 124.810377ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:55:15.445438Z","caller":"traceutil/trace.go:171","msg":"trace[978936736] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"157.528511ms","start":"2026-04-20T04:55:15.287894Z","end":"2026-04-20T04:55:15.445423Z","steps":["trace[978936736] 'process raft request' (duration: 32.724314ms)","trace[978936736] 'compare' (duration: 124.068692ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:55:15.445559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.982586ms","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-20T04:55:15.446225Z","caller":"traceutil/trace.go:171","msg":"trace[1167115742] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2132; }","duration":"140.672089ms","start":"2026-04-20T04:55:15.305525Z","end":"2026-04-20T04:55:15.446197Z","steps":["trace[1167115742] 'agreement among raft nodes before linearized reading' (duration: 139.897853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:55:15.445891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.048869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T04:55:15.446343Z","caller":"traceutil/trace.go:171","msg":"trace[1478338684] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2132; }","duration":"148.554619ms","start":"2026-04-20T04:55:15.297761Z","end":"2026-04-20T04:55:15.446316Z","steps":["trace[1478338684] 'agreement among raft nodes before linearized reading' (duration: 147.837815ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:10.759208Z","caller":"traceutil/trace.go:171","msg":"trace[1931088388] transaction","detail":"{read_only:false; response_revision:3780; number_of_response:1; }","duration":"168.095ms","start":"2026-04-20T04:59:10.591078Z","end":"2026-04-20T04:59:10.759173Z","steps":["trace[1931088388] 'process raft request' (duration: 116.999663ms)","trace[1931088388] 'compare' (duration: 50.681789ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:00:25.494471Z","caller":"traceutil/trace.go:171","msg":"trace[1408806630] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"101.13165ms","start":"2026-04-20T05:00:25.393318Z","end":"2026-04-20T05:00:25.494449Z","steps":["trace[1408806630] 'compare' (duration: 94.371203ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:00:25.51118Z","caller":"traceutil/trace.go:171","msg":"trace[412474116] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4774; }","duration":"108.883804ms","start":"2026-04-20T05:00:25.402274Z","end":"2026-04-20T05:00:25.511158Z","steps":["trace[412474116] 'process raft request' (duration: 108.791091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:00:25.511444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.924846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-8tt7t-tls\" ","response":"range_response_count:1 size:2300"} {"level":"info","ts":"2026-04-20T05:00:25.511532Z","caller":"traceutil/trace.go:171","msg":"trace[52610968] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-8tt7t-tls; range_end:; response_count:1; response_revision:4774; }","duration":"112.19258ms","start":"2026-04-20T05:00:25.399321Z","end":"2026-04-20T05:00:25.511513Z","steps":["trace[52610968] 'agreement among raft nodes before linearized reading' (duration: 111.896654ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:00:42.149132Z","caller":"traceutil/trace.go:171","msg":"trace[1823115071] linearizableReadLoop","detail":"{readStateIndex:5389; appliedIndex:5388; }","duration":"181.050962ms","start":"2026-04-20T05:00:41.968047Z","end":"2026-04-20T05:00:42.149097Z","steps":["trace[1823115071] 'read index received' (duration: 141.083419ms)","trace[1823115071] 'applied index is now lower than readState.Index' (duration: 39.966063ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:00:42.149291Z","caller":"traceutil/trace.go:171","msg":"trace[1037588993] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"188.195685ms","start":"2026-04-20T05:00:41.961077Z","end":"2026-04-20T05:00:42.149273Z","steps":["trace[1037588993] 'process raft request' (duration: 147.950667ms)","trace[1037588993] 'compare' (duration: 39.536664ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:00:42.149343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.271366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/memcached-metrics\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:00:42.149397Z","caller":"traceutil/trace.go:171","msg":"trace[981618824] range","detail":"{range_begin:/registry/services/specs/openstack/memcached-metrics; range_end:; response_count:0; response_revision:5191; }","duration":"181.359979ms","start":"2026-04-20T05:00:41.96802Z","end":"2026-04-20T05:00:42.14938Z","steps":["trace[981618824] 'agreement among raft nodes before linearized reading' (duration: 181.257807ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:00:49.99774Z","caller":"traceutil/trace.go:171","msg":"trace[1975628319] transaction","detail":"{read_only:false; response_revision:5329; number_of_response:1; }","duration":"102.336493ms","start":"2026-04-20T05:00:49.89537Z","end":"2026-04-20T05:00:49.997707Z","steps":["trace[1975628319] 'process raft request' (duration: 102.128869ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:00:50.281339Z","caller":"traceutil/trace.go:171","msg":"trace[2078986788] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"101.122239ms","start":"2026-04-20T05:00:50.180158Z","end":"2026-04-20T05:00:50.28128Z","steps":["trace[2078986788] 'process raft request' (duration: 15.521502ms)","trace[2078986788] 'compare' (duration: 85.24235ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:01:51.124674Z","caller":"traceutil/trace.go:171","msg":"trace[288508500] transaction","detail":"{read_only:false; response_revision:5903; number_of_response:1; }","duration":"105.964073ms","start":"2026-04-20T05:01:51.018688Z","end":"2026-04-20T05:01:51.124652Z","steps":["trace[288508500] 'process raft request' (duration: 105.78973ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:02:12.923781Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2964} {"level":"info","ts":"2026-04-20T05:02:12.990335Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2964,"took":"65.282148ms","hash":1328948939,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":33677312,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-20T05:02:12.99039Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1328948939,"revision":2964,"compact-revision":-1} {"level":"info","ts":"2026-04-20T05:07:06.171218Z","caller":"traceutil/trace.go:171","msg":"trace[2098825008] linearizableReadLoop","detail":"{readStateIndex:8527; appliedIndex:8526; }","duration":"106.216695ms","start":"2026-04-20T05:07:06.064972Z","end":"2026-04-20T05:07:06.171188Z","steps":["trace[2098825008] 'read index received' (duration: 88.281625ms)","trace[2098825008] 'applied index is now lower than readState.Index' (duration: 17.93406ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:07:06.171321Z","caller":"traceutil/trace.go:171","msg":"trace[1635729310] transaction","detail":"{read_only:false; response_revision:8235; number_of_response:1; }","duration":"107.8908ms","start":"2026-04-20T05:07:06.063391Z","end":"2026-04-20T05:07:06.171282Z","steps":["trace[1635729310] 'process raft request' (duration: 89.848518ms)","trace[1635729310] 'compare' (duration: 17.829347ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:07:06.171553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.555932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-20T05:07:06.171635Z","caller":"traceutil/trace.go:171","msg":"trace[1371093104] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:8235; }","duration":"106.674144ms","start":"2026-04-20T05:07:06.064944Z","end":"2026-04-20T05:07:06.171618Z","steps":["trace[1371093104] 'agreement among raft nodes before linearized reading' (duration: 106.404809ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:07.386557Z","caller":"traceutil/trace.go:171","msg":"trace[2401718] linearizableReadLoop","detail":"{readStateIndex:8530; appliedIndex:8529; }","duration":"114.02067ms","start":"2026-04-20T05:07:07.272515Z","end":"2026-04-20T05:07:07.386536Z","steps":["trace[2401718] 'read index received' (duration: 113.825607ms)","trace[2401718] 'applied index is now lower than readState.Index' (duration: 194.323µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:07:07.386605Z","caller":"traceutil/trace.go:171","msg":"trace[1188023615] transaction","detail":"{read_only:false; response_revision:8238; number_of_response:1; }","duration":"115.701255ms","start":"2026-04-20T05:07:07.270877Z","end":"2026-04-20T05:07:07.386578Z","steps":["trace[1188023615] 'process raft request' (duration: 115.518921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:07:07.38679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.236165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T05:07:07.386823Z","caller":"traceutil/trace.go:171","msg":"trace[168777319] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8238; }","duration":"114.353148ms","start":"2026-04-20T05:07:07.27246Z","end":"2026-04-20T05:07:07.386814Z","steps":["trace[168777319] 'agreement among raft nodes before linearized reading' (duration: 114.191995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:07:07.386925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.365478ms","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-20T05:07:07.38702Z","caller":"traceutil/trace.go:171","msg":"trace[1728628939] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8238; }","duration":"103.49708ms","start":"2026-04-20T05:07:07.283501Z","end":"2026-04-20T05:07:07.386999Z","steps":["trace[1728628939] 'agreement among raft nodes before linearized reading' (duration: 103.198165ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:07.634154Z","caller":"traceutil/trace.go:171","msg":"trace[1478368179] transaction","detail":"{read_only:false; response_revision:8239; number_of_response:1; }","duration":"243.881809ms","start":"2026-04-20T05:07:07.390239Z","end":"2026-04-20T05:07:07.634121Z","steps":["trace[1478368179] 'process raft request' (duration: 220.129784ms)","trace[1478368179] 'compare' (duration: 23.339017ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:07:07.634152Z","caller":"traceutil/trace.go:171","msg":"trace[2056286771] transaction","detail":"{read_only:false; response_revision:8240; number_of_response:1; }","duration":"243.109254ms","start":"2026-04-20T05:07:07.391015Z","end":"2026-04-20T05:07:07.634124Z","steps":["trace[2056286771] 'process raft request' (duration: 242.991622ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:08.054468Z","caller":"traceutil/trace.go:171","msg":"trace[1127987474] transaction","detail":"{read_only:false; response_revision:8244; number_of_response:1; }","duration":"116.375388ms","start":"2026-04-20T05:07:07.938066Z","end":"2026-04-20T05:07:08.054441Z","steps":["trace[1127987474] 'process raft request' (duration: 107.44934ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:12.931004Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6069} {"level":"info","ts":"2026-04-20T05:07:13.026132Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6069,"took":"93.185575ms","hash":3898170690,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":23339008,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-20T05:07:13.026212Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3898170690,"revision":6069,"compact-revision":2964} {"level":"info","ts":"2026-04-20T05:07:34.66322Z","caller":"traceutil/trace.go:171","msg":"trace[1057611384] transaction","detail":"{read_only:false; response_revision:8437; number_of_response:1; }","duration":"242.708065ms","start":"2026-04-20T05:07:34.420487Z","end":"2026-04-20T05:07:34.663195Z","steps":["trace[1057611384] 'process raft request' (duration: 242.548452ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:34.887258Z","caller":"traceutil/trace.go:171","msg":"trace[1928406614] linearizableReadLoop","detail":"{readStateIndex:8738; appliedIndex:8737; }","duration":"207.861438ms","start":"2026-04-20T05:07:34.679368Z","end":"2026-04-20T05:07:34.887229Z","steps":["trace[1928406614] 'read index received' (duration: 193.393739ms)","trace[1928406614] 'applied index is now lower than readState.Index' (duration: 14.466269ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:07:34.887395Z","caller":"traceutil/trace.go:171","msg":"trace[1533989537] transaction","detail":"{read_only:false; response_revision:8438; number_of_response:1; }","duration":"431.600414ms","start":"2026-04-20T05:07:34.455778Z","end":"2026-04-20T05:07:34.887378Z","steps":["trace[1533989537] 'process raft request' (duration: 417.029783ms)","trace[1533989537] 'compare' (duration: 14.222275ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:07:34.887533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:07:34.45574Z","time spent":"431.699067ms","remote":"127.0.0.1:36704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:07:34.887823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.440281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-npkq7\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-04-20T05:07:34.888035Z","caller":"traceutil/trace.go:171","msg":"trace[1797552817] range","detail":"{range_begin:/registry/pods/openstack/keepalived-npkq7; range_end:; response_count:1; response_revision:8438; }","duration":"208.685366ms","start":"2026-04-20T05:07:34.679323Z","end":"2026-04-20T05:07:34.888008Z","steps":["trace[1797552817] 'agreement among raft nodes before linearized reading' (duration: 208.328949ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:47.912843Z","caller":"traceutil/trace.go:171","msg":"trace[113397308] transaction","detail":"{read_only:false; response_revision:8545; number_of_response:1; }","duration":"199.878468ms","start":"2026-04-20T05:07:47.712941Z","end":"2026-04-20T05:07:47.912819Z","steps":["trace[113397308] 'process raft request' (duration: 199.719365ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:47.91874Z","caller":"traceutil/trace.go:171","msg":"trace[1265816198] linearizableReadLoop","detail":"{readStateIndex:8852; appliedIndex:8850; }","duration":"108.785496ms","start":"2026-04-20T05:07:47.809937Z","end":"2026-04-20T05:07:47.918723Z","steps":["trace[1265816198] 'read index received' (duration: 102.718995ms)","trace[1265816198] 'applied index is now lower than readState.Index' (duration: 6.065271ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:07:47.918837Z","caller":"traceutil/trace.go:171","msg":"trace[1823750302] transaction","detail":"{read_only:false; response_revision:8546; number_of_response:1; }","duration":"130.318297ms","start":"2026-04-20T05:07:47.788486Z","end":"2026-04-20T05:07:47.918804Z","steps":["trace[1823750302] 'process raft request' (duration: 130.135693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:07:47.918878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.93595ms","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-20T05:07:47.918936Z","caller":"traceutil/trace.go:171","msg":"trace[932480294] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8546; }","duration":"109.004531ms","start":"2026-04-20T05:07:47.809917Z","end":"2026-04-20T05:07:47.918922Z","steps":["trace[932480294] 'agreement among raft nodes before linearized reading' (duration: 108.904039ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:49.359789Z","caller":"traceutil/trace.go:171","msg":"trace[810709506] transaction","detail":"{read_only:false; response_revision:8562; number_of_response:1; }","duration":"121.856749ms","start":"2026-04-20T05:07:49.237915Z","end":"2026-04-20T05:07:49.359772Z","steps":["trace[810709506] 'process raft request' (duration: 121.744056ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:08:37.287962Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000249f.wal"} {"level":"warn","ts":"2026-04-20T05:09:01.605227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.955044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-npkq7\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-04-20T05:09:01.605411Z","caller":"traceutil/trace.go:171","msg":"trace[418996087] range","detail":"{range_begin:/registry/pods/openstack/keepalived-npkq7; range_end:; response_count:1; response_revision:9286; }","duration":"147.194598ms","start":"2026-04-20T05:09:01.458195Z","end":"2026-04-20T05:09:01.605389Z","steps":["trace[418996087] 'range keys from in-memory index tree' (duration: 146.691969ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:09:52.763976Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51a5c416a4d98c86","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T05:09:52.771457Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T05:09:52.771566Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T05:12:12.937387Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8273} {"level":"info","ts":"2026-04-20T05:12:13.021686Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8273,"took":"82.071428ms","hash":1364506115,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":24915968,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-20T05:12:13.021764Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1364506115,"revision":8273,"compact-revision":6069} {"level":"info","ts":"2026-04-20T05:17:12.944407Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10667} {"level":"info","ts":"2026-04-20T05:17:13.029272Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10667,"took":"82.606392ms","hash":1229201924,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":20508672,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-20T05:17:13.029333Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1229201924,"revision":10667,"compact-revision":8273}