{"level":"warn","ts":"2026-04-22T06:03:22.787037Z","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-22T06:03:22.787117Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-22T06:03:22.787179Z","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-22T06:03:22.787187Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-04-22T06:03:22.787215Z","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-22T06:03:22.787817Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-04-22T06:03:22.788085Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-22T06:03:22.792479Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.194548ms"} {"level":"info","ts":"2026-04-22T06:03:22.799952Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-04-22T06:03:22.800058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T06:03:22.800086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-04-22T06:03:22.800101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T06:03:22.800116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-04-22T06:03:22.800168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-04-22T06:03:22.8057Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T06:03:22.808883Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T06:03:22.811034Z","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-22T06:03:22.813089Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T06:03:22.813265Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T06:03:22.813392Z","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-22T06:03:22.813552Z","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-22T06:03:22.813608Z","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-22T06:03:22.814498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-04-22T06:03:22.814704Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-04-22T06:03:22.816026Z","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-22T06:03:22.816127Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-04-22T06:03:22.816196Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-04-22T06:03:22.816314Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T06:03:22.816371Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T06:03:22.901062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T06:03:22.901132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T06:03:22.901168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-04-22T06:03:22.901194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-04-22T06:03:22.901209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-04-22T06:03:22.901226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-04-22T06:03:22.90124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-04-22T06:03:22.902227Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:03:22.903642Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T06:03:22.903713Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T06:03:22.903631Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T06:03:22.904005Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T06:03:22.904042Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T06:03:22.907129Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-04-22T06:03:22.907792Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:03:22.907834Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T06:03:22.907948Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:03:22.907983Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:04:13.205427Z","caller":"traceutil/trace.go:171","msg":"trace[12841784] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"118.751923ms","start":"2026-04-22T06:04:13.086652Z","end":"2026-04-22T06:04:13.205404Z","steps":["trace[12841784] 'process raft request' (duration: 63.21219ms)","trace[12841784] 'compare' (duration: 55.418039ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:04:13.216075Z","caller":"traceutil/trace.go:171","msg":"trace[1959957830] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"120.842593ms","start":"2026-04-22T06:04:13.095202Z","end":"2026-04-22T06:04:13.216045Z","steps":["trace[1959957830] 'process raft request' (duration: 120.526474ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:04:13.526047Z","caller":"traceutil/trace.go:171","msg":"trace[1815380087] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"291.374363ms","start":"2026-04-22T06:04:13.234648Z","end":"2026-04-22T06:04:13.526022Z","steps":["trace[1815380087] 'process raft request' (duration: 241.14441ms)","trace[1815380087] 'compare' (duration: 50.112499ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:04:13.614501Z","caller":"traceutil/trace.go:171","msg":"trace[323294791] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"370.199704ms","start":"2026-04-22T06:04:13.244267Z","end":"2026-04-22T06:04:13.614467Z","steps":["trace[323294791] 'process raft request' (duration: 369.773622ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:04:13.614676Z","caller":"traceutil/trace.go:171","msg":"trace[547133076] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"340.537494ms","start":"2026-04-22T06:04:13.274113Z","end":"2026-04-22T06:04:13.61465Z","steps":["trace[547133076] 'process raft request' (duration: 340.199505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:13.615036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:13.244251Z","time spent":"370.330118ms","remote":"127.0.0.1:58528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T06:04:13.615286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:13.274092Z","time spent":"340.653707ms","remote":"127.0.0.1:58528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:04:18.590169Z","caller":"traceutil/trace.go:171","msg":"trace[777156721] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"164.747485ms","start":"2026-04-22T06:04:18.425379Z","end":"2026-04-22T06:04:18.590126Z","steps":["trace[777156721] 'process raft request' (duration: 154.32647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:19.08337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.942415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:04:19.083563Z","caller":"traceutil/trace.go:171","msg":"trace[2112094743] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"432.586221ms","start":"2026-04-22T06:04:18.650944Z","end":"2026-04-22T06:04:19.08353Z","steps":["trace[2112094743] 'process raft request' (duration: 144.218905ms)","trace[2112094743] 'compare' (duration: 287.7725ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:04:19.083775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:18.650929Z","time spent":"432.709934ms","remote":"127.0.0.1:58802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T06:04:33.579158Z","caller":"traceutil/trace.go:171","msg":"trace[167874315] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"153.811916ms","start":"2026-04-22T06:04:33.425324Z","end":"2026-04-22T06:04:33.579135Z","steps":["trace[167874315] 'process raft request' (duration: 153.627871ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:22.833341Z","caller":"traceutil/trace.go:171","msg":"trace[1409129708] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"125.256966ms","start":"2026-04-22T06:05:22.708062Z","end":"2026-04-22T06:05:22.833319Z","steps":["trace[1409129708] 'process raft request' (duration: 125.087001ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:46.405089Z","caller":"traceutil/trace.go:171","msg":"trace[1294030793] linearizableReadLoop","detail":"{readStateIndex:1917; appliedIndex:1916; }","duration":"145.430161ms","start":"2026-04-22T06:05:46.259631Z","end":"2026-04-22T06:05:46.405061Z","steps":["trace[1294030793] 'read index received' (duration: 145.142193ms)","trace[1294030793] 'applied index is now lower than readState.Index' (duration: 284.008µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:05:46.405362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.710988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T06:05:46.405452Z","caller":"traceutil/trace.go:171","msg":"trace[1622233933] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1844; }","duration":"145.843772ms","start":"2026-04-22T06:05:46.259586Z","end":"2026-04-22T06:05:46.40543Z","steps":["trace[1622233933] 'agreement among raft nodes before linearized reading' (duration: 145.595585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:46.405522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.66821ms","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-22T06:05:46.405633Z","caller":"traceutil/trace.go:171","msg":"trace[2128692216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1844; }","duration":"123.830814ms","start":"2026-04-22T06:05:46.281782Z","end":"2026-04-22T06:05:46.405613Z","steps":["trace[2128692216] 'agreement among raft nodes before linearized reading' (duration: 123.550746ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:46.539956Z","caller":"traceutil/trace.go:171","msg":"trace[1732316638] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"129.912105ms","start":"2026-04-22T06:05:46.410018Z","end":"2026-04-22T06:05:46.53993Z","steps":["trace[1732316638] 'process raft request' (duration: 129.790032ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:46.539953Z","caller":"traceutil/trace.go:171","msg":"trace[1552736225] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"133.590298ms","start":"2026-04-22T06:05:46.406323Z","end":"2026-04-22T06:05:46.539914Z","steps":["trace[1552736225] 'process raft request' (duration: 88.548274ms)","trace[1552736225] 'compare' (duration: 44.803817ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:05:46.540144Z","caller":"traceutil/trace.go:171","msg":"trace[2132717361] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"129.492443ms","start":"2026-04-22T06:05:46.410642Z","end":"2026-04-22T06:05:46.540134Z","steps":["trace[2132717361] 'process raft request' (duration: 129.254186ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:59.256435Z","caller":"traceutil/trace.go:171","msg":"trace[1753686826] linearizableReadLoop","detail":"{readStateIndex:2028; appliedIndex:2027; }","duration":"105.757938ms","start":"2026-04-22T06:05:59.150649Z","end":"2026-04-22T06:05:59.256407Z","steps":["trace[1753686826] 'read index received' (duration: 105.551363ms)","trace[1753686826] 'applied index is now lower than readState.Index' (duration: 205.635µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:05:59.256719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.041046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-22T06:05:59.256762Z","caller":"traceutil/trace.go:171","msg":"trace[1589105732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1953; }","duration":"106.137619ms","start":"2026-04-22T06:05:59.150614Z","end":"2026-04-22T06:05:59.256751Z","steps":["trace[1589105732] 'agreement among raft nodes before linearized reading' (duration: 105.925893ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:59.256886Z","caller":"traceutil/trace.go:171","msg":"trace[578175073] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"114.126383ms","start":"2026-04-22T06:05:59.142724Z","end":"2026-04-22T06:05:59.25685Z","steps":["trace[578175073] 'process raft request' (duration: 113.550517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:59.515027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.438399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-22T06:05:59.515398Z","caller":"traceutil/trace.go:171","msg":"trace[344077024] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1955; }","duration":"167.940342ms","start":"2026-04-22T06:05:59.347425Z","end":"2026-04-22T06:05:59.515365Z","steps":["trace[344077024] 'range keys from in-memory index tree' (duration: 167.114279ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:02.130224Z","caller":"traceutil/trace.go:171","msg":"trace[641082734] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"173.001795ms","start":"2026-04-22T06:06:01.957197Z","end":"2026-04-22T06:06:02.130199Z","steps":["trace[641082734] 'process raft request' (duration: 172.83895ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:42.066Z","caller":"traceutil/trace.go:171","msg":"trace[1832531485] linearizableReadLoop","detail":"{readStateIndex:2283; appliedIndex:2282; }","duration":"173.34873ms","start":"2026-04-22T06:06:41.892618Z","end":"2026-04-22T06:06:42.065967Z","steps":["trace[1832531485] 'read index received' (duration: 172.98429ms)","trace[1832531485] 'applied index is now lower than readState.Index' (duration: 363.11µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:06:42.066095Z","caller":"traceutil/trace.go:171","msg":"trace[1810240361] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"186.708981ms","start":"2026-04-22T06:06:41.879345Z","end":"2026-04-22T06:06:42.066054Z","steps":["trace[1810240361] 'process raft request' (duration: 186.417053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:42.066298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.643478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-22T06:06:42.066348Z","caller":"traceutil/trace.go:171","msg":"trace[1522462664] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2198; }","duration":"173.7185ms","start":"2026-04-22T06:06:41.892614Z","end":"2026-04-22T06:06:42.066332Z","steps":["trace[1522462664] 'agreement among raft nodes before linearized reading' (duration: 173.512374ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:42.367285Z","caller":"traceutil/trace.go:171","msg":"trace[846570587] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"264.495209ms","start":"2026-04-22T06:06:42.102757Z","end":"2026-04-22T06:06:42.367252Z","steps":["trace[846570587] 'process raft request' (duration: 264.334454ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:25.686314Z","caller":"traceutil/trace.go:171","msg":"trace[1101258282] transaction","detail":"{read_only:false; response_revision:2606; number_of_response:1; }","duration":"204.181532ms","start":"2026-04-22T06:07:25.482104Z","end":"2026-04-22T06:07:25.686285Z","steps":["trace[1101258282] 'process raft request' (duration: 204.021928ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:25.686489Z","caller":"traceutil/trace.go:171","msg":"trace[2128839316] linearizableReadLoop","detail":"{readStateIndex:2707; appliedIndex:2707; }","duration":"169.674336ms","start":"2026-04-22T06:07:25.516725Z","end":"2026-04-22T06:07:25.6864Z","steps":["trace[2128839316] 'read index received' (duration: 169.628065ms)","trace[2128839316] 'applied index is now lower than readState.Index' (duration: 41.761µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:07:25.686684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.943993ms","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-22T06:07:25.686757Z","caller":"traceutil/trace.go:171","msg":"trace[285426388] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2606; }","duration":"170.084267ms","start":"2026-04-22T06:07:25.516657Z","end":"2026-04-22T06:07:25.686741Z","steps":["trace[285426388] 'agreement among raft nodes before linearized reading' (duration: 169.85202ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:25.687051Z","caller":"traceutil/trace.go:171","msg":"trace[137331869] transaction","detail":"{read_only:false; response_revision:2607; number_of_response:1; }","duration":"116.245919ms","start":"2026-04-22T06:07:25.57078Z","end":"2026-04-22T06:07:25.687026Z","steps":["trace[137331869] 'process raft request' (duration: 116.078813ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:25.687152Z","caller":"traceutil/trace.go:171","msg":"trace[1310993748] transaction","detail":"{read_only:false; response_revision:2608; number_of_response:1; }","duration":"115.319842ms","start":"2026-04-22T06:07:25.571811Z","end":"2026-04-22T06:07:25.687131Z","steps":["trace[1310993748] 'process raft request' (duration: 115.171098ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:59.957089Z","caller":"traceutil/trace.go:171","msg":"trace[1476245848] transaction","detail":"{read_only:false; response_revision:2812; number_of_response:1; }","duration":"117.055491ms","start":"2026-04-22T06:07:59.840005Z","end":"2026-04-22T06:07:59.957061Z","steps":["trace[1476245848] 'process raft request' (duration: 116.800504ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:59.966482Z","caller":"traceutil/trace.go:171","msg":"trace[1404697896] transaction","detail":"{read_only:false; response_revision:2813; number_of_response:1; }","duration":"125.700309ms","start":"2026-04-22T06:07:59.840707Z","end":"2026-04-22T06:07:59.966408Z","steps":["trace[1404697896] 'process raft request' (duration: 124.840845ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:00.160126Z","caller":"traceutil/trace.go:171","msg":"trace[1044874361] transaction","detail":"{read_only:false; response_revision:2816; number_of_response:1; }","duration":"102.298911ms","start":"2026-04-22T06:08:00.057796Z","end":"2026-04-22T06:08:00.160095Z","steps":["trace[1044874361] 'process raft request' (duration: 102.140347ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:10:32.096389Z","caller":"traceutil/trace.go:171","msg":"trace[1852130835] transaction","detail":"{read_only:false; response_revision:3816; number_of_response:1; }","duration":"102.964516ms","start":"2026-04-22T06:10:31.993398Z","end":"2026-04-22T06:10:32.096363Z","steps":["trace[1852130835] 'process raft request' (duration: 102.790511ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:10:32.102829Z","caller":"traceutil/trace.go:171","msg":"trace[164539579] transaction","detail":"{read_only:false; response_revision:3817; number_of_response:1; }","duration":"106.289781ms","start":"2026-04-22T06:10:31.996497Z","end":"2026-04-22T06:10:32.102787Z","steps":["trace[164539579] 'process raft request' (duration: 106.077295ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:49.752782Z","caller":"traceutil/trace.go:171","msg":"trace[1694386394] linearizableReadLoop","detail":"{readStateIndex:4881; appliedIndex:4880; }","duration":"135.669252ms","start":"2026-04-22T06:11:49.617087Z","end":"2026-04-22T06:11:49.752756Z","steps":["trace[1694386394] 'read index received' (duration: 10.977928ms)","trace[1694386394] 'applied index is now lower than readState.Index' (duration: 124.689994ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:11:49.752886Z","caller":"traceutil/trace.go:171","msg":"trace[552181317] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"139.347885ms","start":"2026-04-22T06:11:49.61351Z","end":"2026-04-22T06:11:49.752858Z","steps":["trace[552181317] 'process raft request' (duration: 120.378304ms)","trace[552181317] 'compare' (duration: 18.707794ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:11:49.753132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.027921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:8 size:50522"} {"level":"info","ts":"2026-04-22T06:11:49.753182Z","caller":"traceutil/trace.go:171","msg":"trace[1345011565] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:8; response_revision:4702; }","duration":"136.073393ms","start":"2026-04-22T06:11:49.617082Z","end":"2026-04-22T06:11:49.753155Z","steps":["trace[1345011565] 'agreement among raft nodes before linearized reading' (duration: 135.820176ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:49.753993Z","caller":"traceutil/trace.go:171","msg":"trace[1941675991] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"117.329227ms","start":"2026-04-22T06:11:49.636591Z","end":"2026-04-22T06:11:49.75392Z","steps":["trace[1941675991] 'process raft request' (duration: 117.151722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:11:49.754063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.649973ms","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-22T06:11:49.754096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.835564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-22T06:11:49.754136Z","caller":"traceutil/trace.go:171","msg":"trace[1869826519] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4703; }","duration":"129.724106ms","start":"2026-04-22T06:11:49.624402Z","end":"2026-04-22T06:11:49.754126Z","steps":["trace[1869826519] 'agreement among raft nodes before linearized reading' (duration: 129.551541ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:49.754166Z","caller":"traceutil/trace.go:171","msg":"trace[473733470] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4703; }","duration":"137.060571ms","start":"2026-04-22T06:11:49.617089Z","end":"2026-04-22T06:11:49.75415Z","steps":["trace[473733470] 'agreement among raft nodes before linearized reading' (duration: 136.761702ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:57.686212Z","caller":"traceutil/trace.go:171","msg":"trace[1874948442] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"135.505667ms","start":"2026-04-22T06:11:57.550672Z","end":"2026-04-22T06:11:57.686178Z","steps":["trace[1874948442] 'process raft request' (duration: 135.325452ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:59.970269Z","caller":"traceutil/trace.go:171","msg":"trace[346253960] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"108.688996ms","start":"2026-04-22T06:11:59.861551Z","end":"2026-04-22T06:11:59.970239Z","steps":["trace[346253960] 'process raft request' (duration: 108.553232ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:12:09.139341Z","caller":"traceutil/trace.go:171","msg":"trace[673841713] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"161.503585ms","start":"2026-04-22T06:12:08.977815Z","end":"2026-04-22T06:12:09.139319Z","steps":["trace[673841713] 'process raft request' (duration: 161.443614ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:12:09.139751Z","caller":"traceutil/trace.go:171","msg":"trace[1650072165] linearizableReadLoop","detail":"{readStateIndex:5429; appliedIndex:5426; }","duration":"185.238662ms","start":"2026-04-22T06:12:08.954493Z","end":"2026-04-22T06:12:09.139732Z","steps":["trace[1650072165] 'read index received' (duration: 6.286597ms)","trace[1650072165] 'applied index is now lower than readState.Index' (duration: 178.950285ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:12:09.139888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.371615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:12:09.139956Z","caller":"traceutil/trace.go:171","msg":"trace[1604237327] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5239; }","duration":"185.489848ms","start":"2026-04-22T06:12:08.954454Z","end":"2026-04-22T06:12:09.139944Z","steps":["trace[1604237327] 'agreement among raft nodes before linearized reading' (duration: 185.338374ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:12:09.140327Z","caller":"traceutil/trace.go:171","msg":"trace[1233409885] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"210.243062ms","start":"2026-04-22T06:12:08.93007Z","end":"2026-04-22T06:12:09.140313Z","steps":["trace[1233409885] 'process raft request' (duration: 168.590594ms)","trace[1233409885] 'compare' (duration: 40.025042ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:12:09.140578Z","caller":"traceutil/trace.go:171","msg":"trace[613653387] transaction","detail":"{read_only:false; response_revision:5236; number_of_response:1; }","duration":"207.233338ms","start":"2026-04-22T06:12:08.933333Z","end":"2026-04-22T06:12:09.140567Z","steps":["trace[613653387] 'process raft request' (duration: 205.772946ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:12:09.14043Z","caller":"traceutil/trace.go:171","msg":"trace[1267377298] transaction","detail":"{read_only:false; response_revision:5237; number_of_response:1; }","duration":"166.97099ms","start":"2026-04-22T06:12:08.973426Z","end":"2026-04-22T06:12:09.140397Z","steps":["trace[1267377298] 'process raft request' (duration: 165.736255ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:12:09.142067Z","caller":"traceutil/trace.go:171","msg":"trace[821731612] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"164.889231ms","start":"2026-04-22T06:12:08.977157Z","end":"2026-04-22T06:12:09.142047Z","steps":["trace[821731612] 'process raft request' (duration: 162.053071ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:13:23.28401Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2943} {"level":"info","ts":"2026-04-22T06:13:23.35552Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2943,"took":"70.100224ms","hash":1470545091,"current-db-size-bytes":57757696,"current-db-size":"58 MB","current-db-size-in-use-bytes":33361920,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-22T06:13:23.355651Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1470545091,"revision":2943,"compact-revision":-1} {"level":"info","ts":"2026-04-22T06:18:23.29024Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6011} {"level":"info","ts":"2026-04-22T06:18:23.379539Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6011,"took":"87.300693ms","hash":423534547,"current-db-size-bytes":57757696,"current-db-size":"58 MB","current-db-size-in-use-bytes":23293952,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-22T06:18:23.379617Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":423534547,"revision":6011,"compact-revision":2943} {"level":"info","ts":"2026-04-22T06:18:25.616049Z","caller":"traceutil/trace.go:171","msg":"trace[11519517] transaction","detail":"{read_only:false; response_revision:8247; number_of_response:1; }","duration":"243.953285ms","start":"2026-04-22T06:18:25.37207Z","end":"2026-04-22T06:18:25.616023Z","steps":["trace[11519517] 'process raft request' (duration: 243.808831ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:18:25.757983Z","caller":"traceutil/trace.go:171","msg":"trace[363645926] transaction","detail":"{read_only:false; response_revision:8248; number_of_response:1; }","duration":"136.256371ms","start":"2026-04-22T06:18:25.621669Z","end":"2026-04-22T06:18:25.757925Z","steps":["trace[363645926] 'process raft request' (duration: 132.480706ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:18:37.280153Z","caller":"traceutil/trace.go:171","msg":"trace[1465142427] linearizableReadLoop","detail":"{readStateIndex:8598; appliedIndex:8597; }","duration":"144.236005ms","start":"2026-04-22T06:18:37.135882Z","end":"2026-04-22T06:18:37.280118Z","steps":["trace[1465142427] 'read index received' (duration: 122.95295ms)","trace[1465142427] 'applied index is now lower than readState.Index' (duration: 21.281795ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:18:37.280458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.554984ms","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-22T06:18:37.280517Z","caller":"traceutil/trace.go:171","msg":"trace[1827069246] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8309; }","duration":"144.670248ms","start":"2026-04-22T06:18:37.135832Z","end":"2026-04-22T06:18:37.280502Z","steps":["trace[1827069246] 'agreement among raft nodes before linearized reading' (duration: 144.41861ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:18:37.280531Z","caller":"traceutil/trace.go:171","msg":"trace[401017820] transaction","detail":"{read_only:false; response_revision:8309; number_of_response:1; }","duration":"144.844952ms","start":"2026-04-22T06:18:37.135654Z","end":"2026-04-22T06:18:37.280499Z","steps":["trace[401017820] 'process raft request' (duration: 123.170916ms)","trace[401017820] 'compare' (duration: 21.156331ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:19:06.417663Z","caller":"traceutil/trace.go:171","msg":"trace[1891601147] transaction","detail":"{read_only:false; response_revision:8515; number_of_response:1; }","duration":"327.44378ms","start":"2026-04-22T06:19:06.090199Z","end":"2026-04-22T06:19:06.417643Z","steps":["trace[1891601147] 'process raft request' (duration: 327.323336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:06.417802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:06.090183Z","time spent":"327.545233ms","remote":"127.0.0.1:58732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:19:06.417853Z","caller":"traceutil/trace.go:171","msg":"trace[689529088] linearizableReadLoop","detail":"{readStateIndex:8811; appliedIndex:8811; }","duration":"314.713556ms","start":"2026-04-22T06:19:06.103116Z","end":"2026-04-22T06:19:06.41783Z","steps":["trace[689529088] 'read index received' (duration: 314.707466ms)","trace[689529088] 'applied index is now lower than readState.Index' (duration: 4.97µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:19:06.418024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.926853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dwdgb\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-22T06:19:06.418065Z","caller":"traceutil/trace.go:171","msg":"trace[1977925670] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dwdgb; range_end:; response_count:1; response_revision:8515; }","duration":"315.011115ms","start":"2026-04-22T06:19:06.103044Z","end":"2026-04-22T06:19:06.418056Z","steps":["trace[1977925670] 'agreement among raft nodes before linearized reading' (duration: 314.903222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:06.418098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:06.103033Z","time spent":"315.056577ms","remote":"127.0.0.1:58670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6546,"request content":"key:\"/registry/pods/openstack/keepalived-dwdgb\" "} {"level":"info","ts":"2026-04-22T06:19:06.418568Z","caller":"traceutil/trace.go:171","msg":"trace[1307072178] transaction","detail":"{read_only:false; response_revision:8516; number_of_response:1; }","duration":"267.560684ms","start":"2026-04-22T06:19:06.150996Z","end":"2026-04-22T06:19:06.418556Z","steps":["trace[1307072178] 'process raft request' (duration: 267.466062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:06.422203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.158721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-22T06:19:06.422244Z","caller":"traceutil/trace.go:171","msg":"trace[1033172001] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:8517; }","duration":"126.238973ms","start":"2026-04-22T06:19:06.295997Z","end":"2026-04-22T06:19:06.422236Z","steps":["trace[1033172001] 'agreement among raft nodes before linearized reading' (duration: 126.119059ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:19:09.60839Z","caller":"traceutil/trace.go:171","msg":"trace[203130067] transaction","detail":"{read_only:false; response_revision:8536; number_of_response:1; }","duration":"143.785121ms","start":"2026-04-22T06:19:09.464585Z","end":"2026-04-22T06:19:09.60837Z","steps":["trace[203130067] 'process raft request' (duration: 143.463421ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:19:09.843452Z","caller":"traceutil/trace.go:171","msg":"trace[2025890079] transaction","detail":"{read_only:false; response_revision:8537; number_of_response:1; }","duration":"230.838222ms","start":"2026-04-22T06:19:09.612579Z","end":"2026-04-22T06:19:09.843418Z","steps":["trace[2025890079] 'process raft request' (duration: 204.943062ms)","trace[2025890079] 'compare' (duration: 25.670714ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:19:19.425475Z","caller":"traceutil/trace.go:171","msg":"trace[498873399] transaction","detail":"{read_only:false; response_revision:8627; number_of_response:1; }","duration":"175.282028ms","start":"2026-04-22T06:19:19.250171Z","end":"2026-04-22T06:19:19.425453Z","steps":["trace[498873399] 'process raft request' (duration: 175.130164ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:19:19.52619Z","caller":"traceutil/trace.go:171","msg":"trace[988262068] linearizableReadLoop","detail":"{readStateIndex:8931; appliedIndex:8929; }","duration":"194.42958ms","start":"2026-04-22T06:19:19.331736Z","end":"2026-04-22T06:19:19.526165Z","steps":["trace[988262068] 'read index received' (duration: 93.576704ms)","trace[988262068] 'applied index is now lower than readState.Index' (duration: 100.852026ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:19:19.526287Z","caller":"traceutil/trace.go:171","msg":"trace[702546770] transaction","detail":"{read_only:false; response_revision:8629; number_of_response:1; }","duration":"188.71604ms","start":"2026-04-22T06:19:19.337563Z","end":"2026-04-22T06:19:19.526279Z","steps":["trace[702546770] 'process raft request' (duration: 188.545805ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:19:19.526306Z","caller":"traceutil/trace.go:171","msg":"trace[1833968013] transaction","detail":"{read_only:false; response_revision:8628; number_of_response:1; }","duration":"194.675397ms","start":"2026-04-22T06:19:19.331601Z","end":"2026-04-22T06:19:19.526277Z","steps":["trace[1833968013] 'process raft request' (duration: 194.369959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:19.526477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.455626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:19:19.526545Z","caller":"traceutil/trace.go:171","msg":"trace[237392244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8629; }","duration":"104.611771ms","start":"2026-04-22T06:19:19.421914Z","end":"2026-04-22T06:19:19.526526Z","steps":["trace[237392244] 'agreement among raft nodes before linearized reading' (duration: 104.471867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:19.526659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.921624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-249qb\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-04-22T06:19:19.526689Z","caller":"traceutil/trace.go:171","msg":"trace[1647937192] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-249qb; range_end:; response_count:1; response_revision:8629; }","duration":"194.999606ms","start":"2026-04-22T06:19:19.331682Z","end":"2026-04-22T06:19:19.526682Z","steps":["trace[1647937192] 'agreement among raft nodes before linearized reading' (duration: 194.880503ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:19:20.342132Z","caller":"traceutil/trace.go:171","msg":"trace[685164251] transaction","detail":"{read_only:false; response_revision:8636; number_of_response:1; }","duration":"126.348925ms","start":"2026-04-22T06:19:20.215754Z","end":"2026-04-22T06:19:20.342103Z","steps":["trace[685164251] 'process raft request' (duration: 125.896782ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:19:20.614622Z","caller":"traceutil/trace.go:171","msg":"trace[811634503] linearizableReadLoop","detail":"{readStateIndex:8940; appliedIndex:8939; }","duration":"104.286181ms","start":"2026-04-22T06:19:20.510311Z","end":"2026-04-22T06:19:20.614597Z","steps":["trace[811634503] 'read index received' (duration: 104.014554ms)","trace[811634503] 'applied index is now lower than readState.Index' (duration: 270.477µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:19:20.614691Z","caller":"traceutil/trace.go:171","msg":"trace[203548792] transaction","detail":"{read_only:false; response_revision:8637; number_of_response:1; }","duration":"123.571798ms","start":"2026-04-22T06:19:20.491079Z","end":"2026-04-22T06:19:20.614651Z","steps":["trace[203548792] 'process raft request' (duration: 123.330501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:20.614823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.35384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dwdgb\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-22T06:19:20.614868Z","caller":"traceutil/trace.go:171","msg":"trace[736851997] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dwdgb; range_end:; response_count:1; response_revision:8637; }","duration":"101.438812ms","start":"2026-04-22T06:19:20.513416Z","end":"2026-04-22T06:19:20.614855Z","steps":["trace[736851997] 'agreement among raft nodes before linearized reading' (duration: 101.33504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:20.614879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.493497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:19:20.615063Z","caller":"traceutil/trace.go:171","msg":"trace[20502592] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:8637; }","duration":"104.701794ms","start":"2026-04-22T06:19:20.510276Z","end":"2026-04-22T06:19:20.614978Z","steps":["trace[20502592] 'agreement among raft nodes before linearized reading' (duration: 104.464856ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:02.697599Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002478.wal"} {"level":"warn","ts":"2026-04-22T06:20:23.136689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.105139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:20:23.136829Z","caller":"traceutil/trace.go:171","msg":"trace[1150442328] linearizableReadLoop","detail":"{readStateIndex:9625; appliedIndex:9624; }","duration":"101.68537ms","start":"2026-04-22T06:20:23.035123Z","end":"2026-04-22T06:20:23.136809Z","steps":["trace[1150442328] 'read index received' (duration: 29.761µs)","trace[1150442328] 'applied index is now lower than readState.Index' (duration: 101.653349ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:20:23.136841Z","caller":"traceutil/trace.go:171","msg":"trace[827286079] transaction","detail":"{read_only:false; response_revision:9304; number_of_response:1; }","duration":"132.999491ms","start":"2026-04-22T06:20:23.003818Z","end":"2026-04-22T06:20:23.136818Z","steps":["trace[827286079] 'process raft request' (duration: 24.664147ms)","trace[827286079] 'compare' (duration: 107.972215ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:20:23.136974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.838714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dwdgb\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-22T06:20:23.137039Z","caller":"traceutil/trace.go:171","msg":"trace[1762850028] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dwdgb; range_end:; response_count:1; response_revision:9304; }","duration":"101.949367ms","start":"2026-04-22T06:20:23.035072Z","end":"2026-04-22T06:20:23.137022Z","steps":["trace[1762850028] 'agreement among raft nodes before linearized reading' (duration: 101.799073ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:35.088953Z","caller":"traceutil/trace.go:171","msg":"trace[2033075434] linearizableReadLoop","detail":"{readStateIndex:9694; appliedIndex:9693; }","duration":"110.232737ms","start":"2026-04-22T06:20:34.978697Z","end":"2026-04-22T06:20:35.08893Z","steps":["trace[2033075434] 'read index received' (duration: 109.97123ms)","trace[2033075434] 'applied index is now lower than readState.Index' (duration: 260.177µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:20:35.089271Z","caller":"traceutil/trace.go:171","msg":"trace[1515579260] transaction","detail":"{read_only:false; response_revision:9371; number_of_response:1; }","duration":"114.722673ms","start":"2026-04-22T06:20:34.97452Z","end":"2026-04-22T06:20:35.089243Z","steps":["trace[1515579260] 'process raft request' (duration: 114.169967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:20:35.089451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.72735ms","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-22T06:20:35.089563Z","caller":"traceutil/trace.go:171","msg":"trace[541481088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9371; }","duration":"110.881925ms","start":"2026-04-22T06:20:34.978655Z","end":"2026-04-22T06:20:35.089537Z","steps":["trace[541481088] 'agreement among raft nodes before linearized reading' (duration: 110.567826ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:35.207517Z","caller":"traceutil/trace.go:171","msg":"trace[308333911] linearizableReadLoop","detail":"{readStateIndex:9695; appliedIndex:9694; }","duration":"118.125076ms","start":"2026-04-22T06:20:35.089369Z","end":"2026-04-22T06:20:35.207494Z","steps":["trace[308333911] 'read index received' (duration: 19.844602ms)","trace[308333911] 'applied index is now lower than readState.Index' (duration: 98.278884ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:20:35.207531Z","caller":"traceutil/trace.go:171","msg":"trace[289721262] transaction","detail":"{read_only:false; response_revision:9372; number_of_response:1; }","duration":"226.014849ms","start":"2026-04-22T06:20:34.981491Z","end":"2026-04-22T06:20:35.207506Z","steps":["trace[289721262] 'process raft request' (duration: 127.733823ms)","trace[289721262] 'compare' (duration: 98.12113ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:20:35.207698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.771551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T06:20:35.20774Z","caller":"traceutil/trace.go:171","msg":"trace[1182370492] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9372; }","duration":"147.829413ms","start":"2026-04-22T06:20:35.059902Z","end":"2026-04-22T06:20:35.207731Z","steps":["trace[1182370492] 'agreement among raft nodes before linearized reading' (duration: 147.676239ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:35.207757Z","caller":"traceutil/trace.go:171","msg":"trace[1742704080] transaction","detail":"{read_only:false; response_revision:9373; number_of_response:1; }","duration":"114.315601ms","start":"2026-04-22T06:20:35.093404Z","end":"2026-04-22T06:20:35.207719Z","steps":["trace[1742704080] 'process raft request' (duration: 114.059573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:20:35.207848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.511254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:20:35.207877Z","caller":"traceutil/trace.go:171","msg":"trace[151927912] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9373; }","duration":"193.566766ms","start":"2026-04-22T06:20:35.014301Z","end":"2026-04-22T06:20:35.207867Z","steps":["trace[151927912] 'agreement among raft nodes before linearized reading' (duration: 193.307779ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:14.227695Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5ac240a6daec2148","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T06:21:14.236048Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-22T06:21:14.236182Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-22T06:23:23.300292Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8235} {"level":"info","ts":"2026-04-22T06:23:23.380167Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8235,"took":"78.198531ms","hash":3821681735,"current-db-size-bytes":57757696,"current-db-size":"58 MB","current-db-size-in-use-bytes":25985024,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-22T06:23:23.380243Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3821681735,"revision":8235,"compact-revision":6011} {"level":"warn","ts":"2026-04-22T06:25:38.363138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.600738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:25:38.363284Z","caller":"traceutil/trace.go:171","msg":"trace[2072402316] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:11336; }","duration":"333.826555ms","start":"2026-04-22T06:25:38.029431Z","end":"2026-04-22T06:25:38.363258Z","steps":["trace[2072402316] 'count revisions from in-memory index tree' (duration: 333.459644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:25:38.363729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:25:38.029406Z","time spent":"334.300847ms","remote":"127.0.0.1:40986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true "} {"level":"warn","ts":"2026-04-22T06:25:39.541124Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398340197075623237,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T06:25:39.697368Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.325359312s","expected-duration":"1s"} {"level":"info","ts":"2026-04-22T06:25:39.699103Z","caller":"traceutil/trace.go:171","msg":"trace[217468144] transaction","detail":"{read_only:false; response_revision:11339; number_of_response:1; }","duration":"1.330408073s","start":"2026-04-22T06:25:38.368661Z","end":"2026-04-22T06:25:39.699069Z","steps":["trace[217468144] 'process raft request' (duration: 1.328897921s)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:25:39.699385Z","caller":"traceutil/trace.go:171","msg":"trace[2141696181] linearizableReadLoop","detail":"{readStateIndex:11734; appliedIndex:11732; }","duration":"658.3263ms","start":"2026-04-22T06:25:39.041041Z","end":"2026-04-22T06:25:39.699367Z","steps":["trace[2141696181] 'read index received' (duration: 656.53064ms)","trace[2141696181] 'applied index is now lower than readState.Index' (duration: 1.79499ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:25:39.699327Z","caller":"traceutil/trace.go:171","msg":"trace[1192292820] transaction","detail":"{read_only:false; response_revision:11340; number_of_response:1; }","duration":"476.271163ms","start":"2026-04-22T06:25:39.223037Z","end":"2026-04-22T06:25:39.699309Z","steps":["trace[1192292820] 'process raft request' (duration: 475.946694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:25:39.699591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.83256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-22T06:25:39.699626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.904674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-22T06:25:39.699615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.561926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:25:39.699632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:25:39.223019Z","time spent":"476.53783ms","remote":"127.0.0.1:58732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:25:39.699647Z","caller":"traceutil/trace.go:171","msg":"trace[403712376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11341; }","duration":"438.995897ms","start":"2026-04-22T06:25:39.260643Z","end":"2026-04-22T06:25:39.699639Z","steps":["trace[403712376] 'agreement among raft nodes before linearized reading' (duration: 438.918775ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:25:39.699643Z","caller":"traceutil/trace.go:171","msg":"trace[1357003049] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:11341; }","duration":"340.921073ms","start":"2026-04-22T06:25:39.358708Z","end":"2026-04-22T06:25:39.699629Z","steps":["trace[1357003049] 'agreement among raft nodes before linearized reading' (duration: 340.81823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:25:39.699645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.765392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dwdgb\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-22T06:25:39.699644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.914449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"warn","ts":"2026-04-22T06:25:39.699669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:25:39.260608Z","time spent":"439.056119ms","remote":"127.0.0.1:58732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-22T06:25:39.69967Z","caller":"traceutil/trace.go:171","msg":"trace[194055042] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11341; }","duration":"658.669619ms","start":"2026-04-22T06:25:39.040986Z","end":"2026-04-22T06:25:39.699656Z","steps":["trace[194055042] 'agreement among raft nodes before linearized reading' (duration: 658.558256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:25:39.699675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:25:39.358693Z","time spent":"340.974934ms","remote":"127.0.0.1:39944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-22T06:25:39.69967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.697928ms","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-22T06:25:39.699701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:25:39.040953Z","time spent":"658.740061ms","remote":"127.0.0.1:58494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-22T06:25:39.6997Z","caller":"traceutil/trace.go:171","msg":"trace[826782757] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:11341; }","duration":"509.020023ms","start":"2026-04-22T06:25:39.190662Z","end":"2026-04-22T06:25:39.699683Z","steps":["trace[826782757] 'agreement among raft nodes before linearized reading' (duration: 508.844788ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:25:39.699733Z","caller":"traceutil/trace.go:171","msg":"trace[1366673843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11341; }","duration":"438.792661ms","start":"2026-04-22T06:25:39.260925Z","end":"2026-04-22T06:25:39.699717Z","steps":["trace[1366673843] 'agreement among raft nodes before linearized reading' (duration: 438.621596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:25:39.69974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:25:39.190635Z","time spent":"509.095274ms","remote":"127.0.0.1:58732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":550,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-04-22T06:25:39.699686Z","caller":"traceutil/trace.go:171","msg":"trace[443236263] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dwdgb; range_end:; response_count:1; response_revision:11341; }","duration":"334.862074ms","start":"2026-04-22T06:25:39.364812Z","end":"2026-04-22T06:25:39.699674Z","steps":["trace[443236263] 'agreement among raft nodes before linearized reading' (duration: 334.748971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:25:39.699775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:25:39.260911Z","time spent":"438.856223ms","remote":"127.0.0.1:58732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T06:25:39.699803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:25:39.364787Z","time spent":"335.009948ms","remote":"127.0.0.1:58670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6546,"request content":"key:\"/registry/pods/openstack/keepalived-dwdgb\" "} {"level":"warn","ts":"2026-04-22T06:25:39.69985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.957228ms","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-22T06:25:39.699947Z","caller":"traceutil/trace.go:171","msg":"trace[551118827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11341; }","duration":"438.103492ms","start":"2026-04-22T06:25:39.261819Z","end":"2026-04-22T06:25:39.699922Z","steps":["trace[551118827] 'agreement among raft nodes before linearized reading' (duration: 437.781613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:25:39.699987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:25:39.261806Z","time spent":"438.172563ms","remote":"127.0.0.1:58732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T06:25:39.69926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:25:38.36865Z","time spent":"1.330528696s","remote":"127.0.0.1:58732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:28:23.305874Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10628} {"level":"info","ts":"2026-04-22T06:28:23.383787Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10628,"took":"75.649343ms","hash":3736928758,"current-db-size-bytes":57757696,"current-db-size":"58 MB","current-db-size-in-use-bytes":20578304,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-22T06:28:23.383843Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3736928758,"revision":10628,"compact-revision":8235}