{"level":"warn","ts":"2026-04-27T19:39:04.42802Z","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-27T19:39:04.428227Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.223:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.223:2380","--initial-cluster=instance=https://199.19.213.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.223: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-27T19:39:04.428338Z","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-27T19:39:04.428362Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.223:2380"]} {"level":"info","ts":"2026-04-27T19:39:04.4284Z","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-27T19:39:04.429359Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.223:2379"]} {"level":"info","ts":"2026-04-27T19:39:04.429463Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.223:2380"],"listen-peer-urls":["https://199.19.213.223:2380"],"advertise-client-urls":["https://199.19.213.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.223: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-27T19:39:04.433989Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.216375ms"} {"level":"info","ts":"2026-04-27T19:39:04.441137Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"12dd93b2fab6fcb","cluster-id":"8ac3bdb9c2c26b53"} {"level":"info","ts":"2026-04-27T19:39:04.441213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T19:39:04.441238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became follower at term 0"} {"level":"info","ts":"2026-04-27T19:39:04.441248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 12dd93b2fab6fcb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T19:39:04.441265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became follower at term 1"} {"level":"info","ts":"2026-04-27T19:39:04.441307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb switched to configuration voters=(84962816215969739)"} {"level":"warn","ts":"2026-04-27T19:39:04.446041Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T19:39:04.447466Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T19:39:04.448766Z","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-27T19:39:04.451488Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"12dd93b2fab6fcb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T19:39:04.451626Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"12dd93b2fab6fcb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T19:39:04.451938Z","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-27T19:39:04.452349Z","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-27T19:39:04.452979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb switched to configuration voters=(84962816215969739)"} {"level":"info","ts":"2026-04-27T19:39:04.453458Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ac3bdb9c2c26b53","local-member-id":"12dd93b2fab6fcb","added-peer-id":"12dd93b2fab6fcb","added-peer-peer-urls":["https://199.19.213.223:2380"]} {"level":"info","ts":"2026-04-27T19:39:04.453063Z","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-27T19:39:04.456794Z","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-27T19:39:04.457038Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"12dd93b2fab6fcb","initial-advertise-peer-urls":["https://199.19.213.223:2380"],"listen-peer-urls":["https://199.19.213.223:2380"],"advertise-client-urls":["https://199.19.213.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T19:39:04.457082Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T19:39:04.457759Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.223:2380"} {"level":"info","ts":"2026-04-27T19:39:04.457807Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.223:2380"} {"level":"info","ts":"2026-04-27T19:39:04.842089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T19:39:04.842149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T19:39:04.842185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb received MsgPreVoteResp from 12dd93b2fab6fcb at term 1"} {"level":"info","ts":"2026-04-27T19:39:04.842204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became candidate at term 2"} {"level":"info","ts":"2026-04-27T19:39:04.842215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb received MsgVoteResp from 12dd93b2fab6fcb at term 2"} {"level":"info","ts":"2026-04-27T19:39:04.842231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became leader at term 2"} {"level":"info","ts":"2026-04-27T19:39:04.842244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 12dd93b2fab6fcb elected leader 12dd93b2fab6fcb at term 2"} {"level":"info","ts":"2026-04-27T19:39:04.85927Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"12dd93b2fab6fcb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.223:2379]}","request-path":"/0/members/12dd93b2fab6fcb/attributes","cluster-id":"8ac3bdb9c2c26b53","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T19:39:04.859444Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T19:39:04.859725Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T19:39:04.859994Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:39:04.861783Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ac3bdb9c2c26b53","local-member-id":"12dd93b2fab6fcb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:39:04.861867Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:39:04.861903Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:39:04.862148Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T19:39:04.862185Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T19:39:04.865004Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.223:2379"} {"level":"info","ts":"2026-04-27T19:39:04.867749Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T19:39:18.051875Z","caller":"traceutil/trace.go:171","msg":"trace[980893082] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:416; }","duration":"142.180926ms","start":"2026-04-27T19:39:17.909661Z","end":"2026-04-27T19:39:18.051842Z","steps":["trace[980893082] 'read index received' (duration: 141.809873ms)","trace[980893082] 'applied index is now lower than readState.Index' (duration: 369.423µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:39:18.0519Z","caller":"traceutil/trace.go:171","msg":"trace[939121075] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"143.154614ms","start":"2026-04-27T19:39:17.908705Z","end":"2026-04-27T19:39:18.05186Z","steps":["trace[939121075] 'process raft request' (duration: 142.867122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:39:18.054079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.122863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-27T19:39:18.054192Z","caller":"traceutil/trace.go:171","msg":"trace[1232978976] range","detail":"{range_begin:/registry/masterleases/199.19.213.223; range_end:; response_count:1; response_revision:404; }","duration":"144.540753ms","start":"2026-04-27T19:39:17.909623Z","end":"2026-04-27T19:39:18.054164Z","steps":["trace[1232978976] 'agreement among raft nodes before linearized reading' (duration: 143.080564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:39:18.286595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.555154ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-27T19:39:18.484217Z","caller":"traceutil/trace.go:171","msg":"trace[1648050642] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"424.00342ms","start":"2026-04-27T19:39:18.060185Z","end":"2026-04-27T19:39:18.484188Z","steps":["trace[1648050642] 'process raft request' (duration: 361.632588ms)","trace[1648050642] 'compare' (duration: 62.123211ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:39:18.484631Z","caller":"traceutil/trace.go:171","msg":"trace[1644847732] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"196.917558ms","start":"2026-04-27T19:39:18.287677Z","end":"2026-04-27T19:39:18.484594Z","steps":["trace[1644847732] 'process raft request' (duration: 196.449455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:39:18.485352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:39:18.060156Z","time spent":"424.145451ms","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T19:39:39.818486Z","caller":"traceutil/trace.go:171","msg":"trace[1040934676] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"188.186888ms","start":"2026-04-27T19:39:39.630264Z","end":"2026-04-27T19:39:39.818451Z","steps":["trace[1040934676] 'read index received' (duration: 187.207612ms)","trace[1040934676] 'applied index is now lower than readState.Index' (duration: 978.066µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:39:39.818571Z","caller":"traceutil/trace.go:171","msg":"trace[1781569968] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"327.039527ms","start":"2026-04-27T19:39:39.491482Z","end":"2026-04-27T19:39:39.818521Z","steps":["trace[1781569968] 'process raft request' (duration: 326.275632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:39:39.818956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.663321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:39:39.819092Z","caller":"traceutil/trace.go:171","msg":"trace[1625537493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"188.861442ms","start":"2026-04-27T19:39:39.630196Z","end":"2026-04-27T19:39:39.819057Z","steps":["trace[1625537493] 'agreement among raft nodes before linearized reading' (duration: 188.428709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:39:39.819604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:39:39.491453Z","time spent":"327.480929ms","remote":"127.0.0.1:49576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T19:39:40.012642Z","caller":"traceutil/trace.go:171","msg":"trace[1190615716] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"186.81634ms","start":"2026-04-27T19:39:39.8258Z","end":"2026-04-27T19:39:40.012616Z","steps":["trace[1190615716] 'process raft request' (duration: 131.928479ms)","trace[1190615716] 'compare' (duration: 54.7651ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:39:40.036734Z","caller":"traceutil/trace.go:171","msg":"trace[1099131972] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"137.977252ms","start":"2026-04-27T19:39:39.89873Z","end":"2026-04-27T19:39:40.036707Z","steps":["trace[1099131972] 'process raft request' (duration: 137.56382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:39:40.52125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.45413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:39:40.521601Z","caller":"traceutil/trace.go:171","msg":"trace[1012620338] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"166.416633ms","start":"2026-04-27T19:39:40.355161Z","end":"2026-04-27T19:39:40.521578Z","steps":["trace[1012620338] 'process raft request' (duration: 166.256892ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:39:40.521663Z","caller":"traceutil/trace.go:171","msg":"trace[187633654] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"336.184925ms","start":"2026-04-27T19:39:40.185373Z","end":"2026-04-27T19:39:40.521558Z","steps":["trace[187633654] 'read index received' (duration: 116.345052ms)","trace[187633654] 'applied index is now lower than readState.Index' (duration: 219.833593ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:39:40.521933Z","caller":"traceutil/trace.go:171","msg":"trace[340084650] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"470.228482ms","start":"2026-04-27T19:39:40.051644Z","end":"2026-04-27T19:39:40.521873Z","steps":["trace[340084650] 'process raft request' (duration: 250.036297ms)","trace[340084650] 'compare' (duration: 219.266399ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:39:40.522149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:39:40.051613Z","time spent":"470.415003ms","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T19:39:40.522192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.769189ms","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-27T19:39:40.522258Z","caller":"traceutil/trace.go:171","msg":"trace[1698154582] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"336.87555ms","start":"2026-04-27T19:39:40.185366Z","end":"2026-04-27T19:39:40.522242Z","steps":["trace[1698154582] 'agreement among raft nodes before linearized reading' (duration: 336.433677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:39:40.52232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:39:40.185299Z","time spent":"337.0089ms","remote":"127.0.0.1:49732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-27T19:39:40.533669Z","caller":"traceutil/trace.go:171","msg":"trace[1639567523] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"103.921271ms","start":"2026-04-27T19:39:40.429723Z","end":"2026-04-27T19:39:40.533644Z","steps":["trace[1639567523] 'process raft request' (duration: 103.242637ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:40:35.385319Z","caller":"traceutil/trace.go:171","msg":"trace[1214511261] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"206.705524ms","start":"2026-04-27T19:40:35.178584Z","end":"2026-04-27T19:40:35.385289Z","steps":["trace[1214511261] 'process raft request' (duration: 206.516729ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:40:35.438427Z","caller":"traceutil/trace.go:171","msg":"trace[2074863135] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"127.770038ms","start":"2026-04-27T19:40:35.310621Z","end":"2026-04-27T19:40:35.438391Z","steps":["trace[2074863135] 'process raft request' (duration: 127.632684ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:23.720731Z","caller":"traceutil/trace.go:171","msg":"trace[688240596] linearizableReadLoop","detail":"{readStateIndex:1963; appliedIndex:1962; }","duration":"307.408174ms","start":"2026-04-27T19:41:23.413291Z","end":"2026-04-27T19:41:23.7207Z","steps":["trace[688240596] 'read index received' (duration: 307.215511ms)","trace[688240596] 'applied index is now lower than readState.Index' (duration: 191.353µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:23.7208Z","caller":"traceutil/trace.go:171","msg":"trace[1269471240] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"379.503988ms","start":"2026-04-27T19:41:23.341236Z","end":"2026-04-27T19:41:23.72074Z","steps":["trace[1269471240] 'process raft request' (duration: 379.267284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:23.721023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:23.341198Z","time spent":"379.699322ms","remote":"127.0.0.1:49732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T19:41:23.721167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.836513ms","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-27T19:41:23.721283Z","caller":"traceutil/trace.go:171","msg":"trace[339913037] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1885; }","duration":"307.993206ms","start":"2026-04-27T19:41:23.413262Z","end":"2026-04-27T19:41:23.721255Z","steps":["trace[339913037] 'agreement among raft nodes before linearized reading' (duration: 307.675059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:23.721352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:23.413239Z","time spent":"308.097897ms","remote":"127.0.0.1:54024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-27T19:41:23.737256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.840951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-04-27T19:41:23.737376Z","caller":"traceutil/trace.go:171","msg":"trace[562002720] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1886; }","duration":"236.007383ms","start":"2026-04-27T19:41:23.501353Z","end":"2026-04-27T19:41:23.737361Z","steps":["trace[562002720] 'agreement among raft nodes before linearized reading' (duration: 235.767009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:23.737645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.701592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:23.737706Z","caller":"traceutil/trace.go:171","msg":"trace[552816900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1886; }","duration":"107.792484ms","start":"2026-04-27T19:41:23.629899Z","end":"2026-04-27T19:41:23.737691Z","steps":["trace[552816900] 'agreement among raft nodes before linearized reading' (duration: 107.698592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:24.100743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.395713ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:41:24.101101Z","caller":"traceutil/trace.go:171","msg":"trace[171935613] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"351.342915ms","start":"2026-04-27T19:41:23.749727Z","end":"2026-04-27T19:41:24.10107Z","steps":["trace[171935613] 'process raft request' (duration: 147.476334ms)","trace[171935613] 'compare' (duration: 203.21466ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:24.101156Z","caller":"traceutil/trace.go:171","msg":"trace[676127872] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"205.201463ms","start":"2026-04-27T19:41:23.895909Z","end":"2026-04-27T19:41:24.101111Z","steps":["trace[676127872] 'process raft request' (duration: 204.961499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:24.101216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:23.749703Z","time spent":"351.460607ms","remote":"127.0.0.1:49660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10967,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T19:41:38.821312Z","caller":"traceutil/trace.go:171","msg":"trace[1365130563] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"123.663183ms","start":"2026-04-27T19:41:38.697634Z","end":"2026-04-27T19:41:38.821297Z","steps":["trace[1365130563] 'process raft request' (duration: 123.555941ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:38.997057Z","caller":"traceutil/trace.go:171","msg":"trace[305530336] linearizableReadLoop","detail":"{readStateIndex:2093; appliedIndex:2092; }","duration":"145.897817ms","start":"2026-04-27T19:41:38.851133Z","end":"2026-04-27T19:41:38.997031Z","steps":["trace[305530336] 'read index received' (duration: 145.228516ms)","trace[305530336] 'applied index is now lower than readState.Index' (duration: 667.601µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:38.997336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.182441ms","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-27T19:41:38.997407Z","caller":"traceutil/trace.go:171","msg":"trace[1634575173] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2011; }","duration":"146.307154ms","start":"2026-04-27T19:41:38.851082Z","end":"2026-04-27T19:41:38.997389Z","steps":["trace[1634575173] 'agreement among raft nodes before linearized reading' (duration: 146.04723ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:38.997853Z","caller":"traceutil/trace.go:171","msg":"trace[968523179] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"226.119749ms","start":"2026-04-27T19:41:38.771716Z","end":"2026-04-27T19:41:38.997835Z","steps":["trace[968523179] 'process raft request' (duration: 224.676956ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:58.029481Z","caller":"traceutil/trace.go:171","msg":"trace[621697285] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"110.005725ms","start":"2026-04-27T19:41:57.919446Z","end":"2026-04-27T19:41:58.029452Z","steps":["trace[621697285] 'process raft request' (duration: 109.64496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:58.381947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.902618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T19:41:58.382018Z","caller":"traceutil/trace.go:171","msg":"trace[1609788929] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2129; }","duration":"173.041939ms","start":"2026-04-27T19:41:58.208959Z","end":"2026-04-27T19:41:58.382001Z","steps":["trace[1609788929] 'count revisions from in-memory index tree' (duration: 172.785226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:58.38233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.247002ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:41:58.382554Z","caller":"traceutil/trace.go:171","msg":"trace[1219199856] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"149.027836ms","start":"2026-04-27T19:41:58.233514Z","end":"2026-04-27T19:41:58.382542Z","steps":["trace[1219199856] 'process raft request' (duration: 38.46107ms)","trace[1219199856] 'compare' (duration: 110.000038ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:58.68529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.796758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:41:58.68553Z","caller":"traceutil/trace.go:171","msg":"trace[909959660] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"211.381549ms","start":"2026-04-27T19:41:58.474095Z","end":"2026-04-27T19:41:58.685476Z","steps":["trace[909959660] 'process raft request' (duration: 86.224916ms)","trace[909959660] 'compare' (duration: 124.665547ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:42:54.133185Z","caller":"traceutil/trace.go:171","msg":"trace[1054180939] transaction","detail":"{read_only:false; response_revision:2533; number_of_response:1; }","duration":"137.095742ms","start":"2026-04-27T19:42:53.996062Z","end":"2026-04-27T19:42:54.133158Z","steps":["trace[1054180939] 'process raft request' (duration: 136.94627ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:27.069518Z","caller":"traceutil/trace.go:171","msg":"trace[1268307220] transaction","detail":"{read_only:false; response_revision:2716; number_of_response:1; }","duration":"130.500769ms","start":"2026-04-27T19:43:26.938988Z","end":"2026-04-27T19:43:27.069488Z","steps":["trace[1268307220] 'process raft request' (duration: 130.350867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:47:13.844451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.552781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:47:13.844541Z","caller":"traceutil/trace.go:171","msg":"trace[1846871847] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4621; }","duration":"214.696024ms","start":"2026-04-27T19:47:13.629824Z","end":"2026-04-27T19:47:13.84452Z","steps":["trace[1846871847] 'range keys from in-memory index tree' (duration: 214.438789ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:47:13.844924Z","caller":"traceutil/trace.go:171","msg":"trace[1011910602] linearizableReadLoop","detail":"{readStateIndex:4805; appliedIndex:4804; }","duration":"191.721284ms","start":"2026-04-27T19:47:13.653155Z","end":"2026-04-27T19:47:13.844876Z","steps":["trace[1011910602] 'read index received' (duration: 104.870628ms)","trace[1011910602] 'applied index is now lower than readState.Index' (duration: 86.849196ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:47:13.845211Z","caller":"traceutil/trace.go:171","msg":"trace[2008026611] transaction","detail":"{read_only:false; response_revision:4622; number_of_response:1; }","duration":"207.281178ms","start":"2026-04-27T19:47:13.637916Z","end":"2026-04-27T19:47:13.845197Z","steps":["trace[2008026611] 'process raft request' (duration: 120.162927ms)","trace[2008026611] 'compare' (duration: 86.251318ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:47:13.84539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.93988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-d6sft\" ","response":"range_response_count:1 size:5148"} {"level":"warn","ts":"2026-04-27T19:47:13.845577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.406066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T19:47:13.845628Z","caller":"traceutil/trace.go:171","msg":"trace[1296604463] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:4622; }","duration":"192.503398ms","start":"2026-04-27T19:47:13.653114Z","end":"2026-04-27T19:47:13.845617Z","steps":["trace[1296604463] 'agreement among raft nodes before linearized reading' (duration: 192.383626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:47:13.845905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.040133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:47:13.845964Z","caller":"traceutil/trace.go:171","msg":"trace[373081819] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:4622; }","duration":"132.119774ms","start":"2026-04-27T19:47:13.713828Z","end":"2026-04-27T19:47:13.845948Z","steps":["trace[373081819] 'agreement among raft nodes before linearized reading' (duration: 132.037302ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:47:13.845441Z","caller":"traceutil/trace.go:171","msg":"trace[336671219] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-d6sft; range_end:; response_count:1; response_revision:4622; }","duration":"171.028532ms","start":"2026-04-27T19:47:13.6744Z","end":"2026-04-27T19:47:13.845429Z","steps":["trace[336671219] 'agreement among raft nodes before linearized reading' (duration: 170.801518ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:47:14.013059Z","caller":"traceutil/trace.go:171","msg":"trace[267438672] transaction","detail":"{read_only:false; response_revision:4624; number_of_response:1; }","duration":"116.308596ms","start":"2026-04-27T19:47:13.896722Z","end":"2026-04-27T19:47:14.01303Z","steps":["trace[267438672] 'process raft request' (duration: 83.985552ms)","trace[267438672] 'compare' (duration: 32.132411ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:47:14.016418Z","caller":"traceutil/trace.go:171","msg":"trace[846696186] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"115.069318ms","start":"2026-04-27T19:47:13.90133Z","end":"2026-04-27T19:47:14.0164Z","steps":["trace[846696186] 'process raft request' (duration: 114.994016ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:47:14.016519Z","caller":"traceutil/trace.go:171","msg":"trace[536982918] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"115.594355ms","start":"2026-04-27T19:47:13.900894Z","end":"2026-04-27T19:47:14.016489Z","steps":["trace[536982918] 'process raft request' (duration: 115.34132ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:47:19.383243Z","caller":"traceutil/trace.go:171","msg":"trace[1718336601] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"156.658901ms","start":"2026-04-27T19:47:19.226548Z","end":"2026-04-27T19:47:19.383207Z","steps":["trace[1718336601] 'process raft request' (duration: 156.508019ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:47:19.421768Z","caller":"traceutil/trace.go:171","msg":"trace[417103615] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"187.177501ms","start":"2026-04-27T19:47:19.23457Z","end":"2026-04-27T19:47:19.421748Z","steps":["trace[417103615] 'process raft request' (duration: 186.980168ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:47:19.421759Z","caller":"traceutil/trace.go:171","msg":"trace[1823688753] transaction","detail":"{read_only:false; response_revision:4721; number_of_response:1; }","duration":"145.531789ms","start":"2026-04-27T19:47:19.276205Z","end":"2026-04-27T19:47:19.421736Z","steps":["trace[1823688753] 'process raft request' (duration: 145.466488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:47:32.56177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.400437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-04-27T19:47:32.561829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.691156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-04-27T19:47:32.561881Z","caller":"traceutil/trace.go:171","msg":"trace[753595121] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4895; }","duration":"134.578179ms","start":"2026-04-27T19:47:32.427277Z","end":"2026-04-27T19:47:32.561855Z","steps":["trace[753595121] 'range keys from in-memory index tree' (duration: 134.202424ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:47:32.561909Z","caller":"traceutil/trace.go:171","msg":"trace[2085232781] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4895; }","duration":"198.827549ms","start":"2026-04-27T19:47:32.363061Z","end":"2026-04-27T19:47:32.561888Z","steps":["trace[2085232781] 'range keys from in-memory index tree' (duration: 198.473263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:47:32.562127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.183245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-04-27T19:47:32.562254Z","caller":"traceutil/trace.go:171","msg":"trace[1165849519] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4895; }","duration":"124.369388ms","start":"2026-04-27T19:47:32.437863Z","end":"2026-04-27T19:47:32.562232Z","steps":["trace[1165849519] 'range keys from in-memory index tree' (duration: 123.958921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:47:32.562381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.335969ms","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-27T19:47:32.56247Z","caller":"traceutil/trace.go:171","msg":"trace[764114092] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4895; }","duration":"234.933588ms","start":"2026-04-27T19:47:32.327515Z","end":"2026-04-27T19:47:32.562448Z","steps":["trace[764114092] 'range keys from in-memory index tree' (duration: 234.004114ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:48:10.978496Z","caller":"traceutil/trace.go:171","msg":"trace[30197431] linearizableReadLoop","detail":"{readStateIndex:5438; appliedIndex:5437; }","duration":"202.036333ms","start":"2026-04-27T19:48:10.776437Z","end":"2026-04-27T19:48:10.978473Z","steps":["trace[30197431] 'read index received' (duration: 134.51622ms)","trace[30197431] 'applied index is now lower than readState.Index' (duration: 67.519493ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:48:10.978548Z","caller":"traceutil/trace.go:171","msg":"trace[446961412] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"226.121375ms","start":"2026-04-27T19:48:10.75241Z","end":"2026-04-27T19:48:10.978531Z","steps":["trace[446961412] 'process raft request' (duration: 158.595992ms)","trace[446961412] 'compare' (duration: 67.402631ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:48:10.978763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.309127ms","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-27T19:48:10.978798Z","caller":"traceutil/trace.go:171","msg":"trace[1804295236] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5238; }","duration":"202.379107ms","start":"2026-04-27T19:48:10.776407Z","end":"2026-04-27T19:48:10.978786Z","steps":["trace[1804295236] 'agreement among raft nodes before linearized reading' (duration: 202.163884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:48:11.050114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.779632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194901"} {"level":"info","ts":"2026-04-27T19:48:11.05019Z","caller":"traceutil/trace.go:171","msg":"trace[1297143381] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5239; }","duration":"160.896144ms","start":"2026-04-27T19:48:10.889278Z","end":"2026-04-27T19:48:11.050174Z","steps":["trace[1297143381] 'agreement among raft nodes before linearized reading' (duration: 159.947691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:48:11.050482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.133186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-27T19:48:11.050648Z","caller":"traceutil/trace.go:171","msg":"trace[1474426660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5239; }","duration":"250.267728ms","start":"2026-04-27T19:48:10.800294Z","end":"2026-04-27T19:48:11.050562Z","steps":["trace[1474426660] 'agreement among raft nodes before linearized reading' (duration: 248.882849ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:49:04.900709Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2916} {"level":"info","ts":"2026-04-27T19:49:04.971846Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2916,"took":"69.306591ms","hash":3218462564,"current-db-size-bytes":54161408,"current-db-size":"54 MB","current-db-size-in-use-bytes":29503488,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-27T19:49:04.971897Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3218462564,"revision":2916,"compact-revision":-1} {"level":"info","ts":"2026-04-27T19:51:08.951271Z","caller":"traceutil/trace.go:171","msg":"trace[587051643] transaction","detail":"{read_only:false; response_revision:6485; number_of_response:1; }","duration":"150.455809ms","start":"2026-04-27T19:51:08.800783Z","end":"2026-04-27T19:51:08.951239Z","steps":["trace[587051643] 'process raft request' (duration: 150.257256ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:51:08.975981Z","caller":"traceutil/trace.go:171","msg":"trace[2044276357] transaction","detail":"{read_only:false; response_revision:6486; number_of_response:1; }","duration":"132.942808ms","start":"2026-04-27T19:51:08.84298Z","end":"2026-04-27T19:51:08.975923Z","steps":["trace[2044276357] 'process raft request' (duration: 132.556524ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:51:08.975925Z","caller":"traceutil/trace.go:171","msg":"trace[973430777] transaction","detail":"{read_only:false; response_revision:6487; number_of_response:1; }","duration":"114.130623ms","start":"2026-04-27T19:51:08.861746Z","end":"2026-04-27T19:51:08.975877Z","steps":["trace[973430777] 'process raft request' (duration: 114.040732ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:54:04.906601Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5653} {"level":"info","ts":"2026-04-27T19:54:04.979651Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5653,"took":"71.434311ms","hash":1786796477,"current-db-size-bytes":54161408,"current-db-size":"54 MB","current-db-size-in-use-bytes":18403328,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-27T19:54:04.979771Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1786796477,"revision":5653,"compact-revision":2916}