{"level":"warn","ts":"2026-05-22T19:03:51.829255Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-22T19:03:51.829339Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-05-22T19:03:51.829416Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-22T19:03:51.829431Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-05-22T19:03:51.829455Z","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-05-22T19:03:51.830204Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-05-22T19:03:51.830295Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-05-22T19:03:51.834827Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.231944ms"} {"level":"info","ts":"2026-05-22T19:03:51.840777Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-05-22T19:03:51.840869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-05-22T19:03:51.840894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-05-22T19:03:51.840911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-22T19:03:51.840922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-05-22T19:03:51.84097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-05-22T19:03:51.852355Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-22T19:03:51.854357Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-22T19:03:51.85585Z","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-05-22T19:03:51.858765Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-22T19:03:51.859039Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-22T19:03:51.85907Z","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-05-22T19:03:51.860514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-05-22T19:03:51.860502Z","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-05-22T19:03:51.860631Z","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-05-22T19:03:51.860776Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-05-22T19:03:51.86449Z","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-05-22T19:03:51.864645Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-05-22T19:03:51.864684Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-05-22T19:03:51.864937Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-22T19:03:51.864985Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-22T19:03:52.441756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-05-22T19:03:52.441861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-22T19:03:52.441902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-05-22T19:03:52.441929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-05-22T19:03:52.441954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-05-22T19:03:52.441976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-05-22T19:03:52.441995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-05-22T19:03:52.450017Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T19:03:52.453909Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-05-22T19:03:52.453937Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-22T19:03:52.454167Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-22T19:03:52.454767Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T19:03:52.454863Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-22T19:03:52.454888Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-22T19:03:52.454891Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T19:03:52.454922Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T19:03:52.456563Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-05-22T19:03:52.456965Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-22T19:04:09.988283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.794435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-22T19:04:09.988411Z","caller":"traceutil/trace.go:171","msg":"trace[1340006041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:369; }","duration":"334.973169ms","start":"2026-05-22T19:04:09.65342Z","end":"2026-05-22T19:04:09.988393Z","steps":["trace[1340006041] 'range keys from in-memory index tree' (duration: 334.691454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:04:09.988464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:04:09.6534Z","time spent":"335.05366ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-22T19:04:10.209135Z","caller":"traceutil/trace.go:171","msg":"trace[511699500] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"216.642554ms","start":"2026-05-22T19:04:09.992466Z","end":"2026-05-22T19:04:10.209109Z","steps":["trace[511699500] 'process raft request' (duration: 216.46506ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:04:10.244198Z","caller":"traceutil/trace.go:171","msg":"trace[46826675] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"251.548613ms","start":"2026-05-22T19:04:09.992623Z","end":"2026-05-22T19:04:10.244171Z","steps":["trace[46826675] 'process raft request' (duration: 251.38293ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:04:28.401467Z","caller":"traceutil/trace.go:171","msg":"trace[1343945179] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"104.143741ms","start":"2026-05-22T19:04:28.297299Z","end":"2026-05-22T19:04:28.401443Z","steps":["trace[1343945179] 'process raft request' (duration: 103.958597ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:04:34.59261Z","caller":"traceutil/trace.go:171","msg":"trace[450145351] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"157.54135ms","start":"2026-05-22T19:04:34.435038Z","end":"2026-05-22T19:04:34.59258Z","steps":["trace[450145351] 'process raft request' (duration: 106.567183ms)","trace[450145351] 'compare' (duration: 50.6383ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:04:34.592635Z","caller":"traceutil/trace.go:171","msg":"trace[2122289502] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"125.828634ms","start":"2026-05-22T19:04:34.466733Z","end":"2026-05-22T19:04:34.592562Z","steps":["trace[2122289502] 'read index received' (duration: 74.817906ms)","trace[2122289502] 'applied index is now lower than readState.Index' (duration: 51.009028ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T19:04:34.59317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.823313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-22T19:04:34.593261Z","caller":"traceutil/trace.go:171","msg":"trace[230598587] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"125.968557ms","start":"2026-05-22T19:04:34.467265Z","end":"2026-05-22T19:04:34.593234Z","steps":["trace[230598587] 'agreement among raft nodes before linearized reading' (duration: 125.766633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:04:34.592887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.101549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-22T19:04:34.593689Z","caller":"traceutil/trace.go:171","msg":"trace[921111548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"126.998819ms","start":"2026-05-22T19:04:34.466675Z","end":"2026-05-22T19:04:34.593674Z","steps":["trace[921111548] 'agreement among raft nodes before linearized reading' (duration: 126.012718ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:04:35.12825Z","caller":"traceutil/trace.go:171","msg":"trace[1959136820] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"350.66457ms","start":"2026-05-22T19:04:34.777561Z","end":"2026-05-22T19:04:35.128226Z","steps":["trace[1959136820] 'process raft request' (duration: 350.089317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:04:35.129949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:04:34.777534Z","time spent":"350.794973ms","remote":"127.0.0.1:55046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T19:04:35.857862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.969236ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-22T19:04:35.858158Z","caller":"traceutil/trace.go:171","msg":"trace[657123120] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:610; }","duration":"606.968016ms","start":"2026-05-22T19:04:35.251174Z","end":"2026-05-22T19:04:35.858142Z","steps":["trace[657123120] 'read index received' (duration: 52.530191ms)","trace[657123120] 'applied index is now lower than readState.Index' (duration: 554.437035ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:04:35.858179Z","caller":"traceutil/trace.go:171","msg":"trace[106325626] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"667.841434ms","start":"2026-05-22T19:04:35.190299Z","end":"2026-05-22T19:04:35.85814Z","steps":["trace[106325626] 'process raft request' (duration: 113.396879ms)","trace[106325626] 'compare' (duration: 553.856873ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T19:04:35.858308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:04:35.190241Z","time spent":"668.002997ms","remote":"127.0.0.1:55450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-22T19:04:35.858373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.870267ms","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-05-22T19:04:35.859083Z","caller":"traceutil/trace.go:171","msg":"trace[252683981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"218.607512ms","start":"2026-05-22T19:04:35.640456Z","end":"2026-05-22T19:04:35.859064Z","steps":["trace[252683981] 'agreement among raft nodes before linearized reading' (duration: 217.858967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:04:35.858374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.619633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-05-22T19:04:35.85937Z","caller":"traceutil/trace.go:171","msg":"trace[2077296405] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:588; }","duration":"370.659276ms","start":"2026-05-22T19:04:35.4887Z","end":"2026-05-22T19:04:35.859359Z","steps":["trace[2077296405] 'agreement among raft nodes before linearized reading' (duration: 369.595403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:04:35.859434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:04:35.488676Z","time spent":"370.745108ms","remote":"127.0.0.1:54976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "} {"level":"warn","ts":"2026-05-22T19:04:35.858349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.143559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T19:04:35.859599Z","caller":"traceutil/trace.go:171","msg":"trace[761624570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"608.479008ms","start":"2026-05-22T19:04:35.25111Z","end":"2026-05-22T19:04:35.859589Z","steps":["trace[761624570] 'agreement among raft nodes before linearized reading' (duration: 607.107408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:04:35.859633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:04:35.251041Z","time spent":"608.583561ms","remote":"127.0.0.1:54954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-22T19:04:35.858327Z","caller":"traceutil/trace.go:171","msg":"trace[1287470168] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"613.78478ms","start":"2026-05-22T19:04:35.244433Z","end":"2026-05-22T19:04:35.858218Z","steps":["trace[1287470168] 'process raft request' (duration: 613.517935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:04:35.859932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:04:35.244403Z","time spent":"615.377905ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T19:05:19.430733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.978828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-22T19:05:19.430815Z","caller":"traceutil/trace.go:171","msg":"trace[1037322656] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1146; }","duration":"135.0916ms","start":"2026-05-22T19:05:19.295707Z","end":"2026-05-22T19:05:19.430799Z","steps":["trace[1037322656] 'range keys from in-memory index tree' (duration: 134.846756ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:06:10.024292Z","caller":"traceutil/trace.go:171","msg":"trace[127639281] linearizableReadLoop","detail":"{readStateIndex:1903; appliedIndex:1902; }","duration":"291.146322ms","start":"2026-05-22T19:06:09.73312Z","end":"2026-05-22T19:06:10.024266Z","steps":["trace[127639281] 'read index received' (duration: 290.956839ms)","trace[127639281] 'applied index is now lower than readState.Index' (duration: 188.183µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:06:10.024426Z","caller":"traceutil/trace.go:171","msg":"trace[69778525] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"351.514343ms","start":"2026-05-22T19:06:09.672867Z","end":"2026-05-22T19:06:10.024381Z","steps":["trace[69778525] 'process raft request' (duration: 351.248497ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:06:10.024567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.438859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0c83c93a-4845-42bc-bd1d-1d5c932baf1a\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-05-22T19:06:10.024616Z","caller":"traceutil/trace.go:171","msg":"trace[989377823] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0c83c93a-4845-42bc-bd1d-1d5c932baf1a; range_end:; response_count:1; response_revision:1830; }","duration":"291.566023ms","start":"2026-05-22T19:06:09.733038Z","end":"2026-05-22T19:06:10.024604Z","steps":["trace[989377823] 'agreement among raft nodes before linearized reading' (duration: 291.39324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:06:10.024647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:06:09.672834Z","time spent":"351.697347ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T19:06:10.024677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.43943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-22T19:06:10.024747Z","caller":"traceutil/trace.go:171","msg":"trace[2000681894] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1830; }","duration":"241.565043ms","start":"2026-05-22T19:06:09.783167Z","end":"2026-05-22T19:06:10.024732Z","steps":["trace[2000681894] 'agreement among raft nodes before linearized reading' (duration: 241.318168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:06:10.444394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.5433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T19:06:10.444486Z","caller":"traceutil/trace.go:171","msg":"trace[69370960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1832; }","duration":"191.692853ms","start":"2026-05-22T19:06:10.252773Z","end":"2026-05-22T19:06:10.444466Z","steps":["trace[69370960] 'range keys from in-memory index tree' (duration: 191.453469ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:06:26.834014Z","caller":"traceutil/trace.go:171","msg":"trace[550591152] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"262.214369ms","start":"2026-05-22T19:06:26.571768Z","end":"2026-05-22T19:06:26.833983Z","steps":["trace[550591152] 'process raft request' (duration: 262.033905ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:06:59.607995Z","caller":"traceutil/trace.go:171","msg":"trace[1868636173] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"113.974232ms","start":"2026-05-22T19:06:59.493972Z","end":"2026-05-22T19:06:59.607946Z","steps":["trace[1868636173] 'process raft request' (duration: 113.809729ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:06:59.612583Z","caller":"traceutil/trace.go:171","msg":"trace[818177416] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"118.507235ms","start":"2026-05-22T19:06:59.494047Z","end":"2026-05-22T19:06:59.612554Z","steps":["trace[818177416] 'process raft request' (duration: 118.336181ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:07:00.481479Z","caller":"traceutil/trace.go:171","msg":"trace[190114310] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"116.020054ms","start":"2026-05-22T19:07:00.365426Z","end":"2026-05-22T19:07:00.481446Z","steps":["trace[190114310] 'process raft request' (duration: 115.794929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:07:06.623603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.811851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-22T19:07:06.623786Z","caller":"traceutil/trace.go:171","msg":"trace[806389608] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2185; }","duration":"120.099717ms","start":"2026-05-22T19:07:06.503661Z","end":"2026-05-22T19:07:06.623761Z","steps":["trace[806389608] 'range keys from in-memory index tree' (duration: 119.562416ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:08:14.21038Z","caller":"traceutil/trace.go:171","msg":"trace[1502405361] linearizableReadLoop","detail":"{readStateIndex:2860; appliedIndex:2858; }","duration":"123.555363ms","start":"2026-05-22T19:08:14.086788Z","end":"2026-05-22T19:08:14.210343Z","steps":["trace[1502405361] 'read index received' (duration: 99.633102ms)","trace[1502405361] 'applied index is now lower than readState.Index' (duration: 23.920631ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T19:08:14.210556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.731267ms","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-05-22T19:08:14.210591Z","caller":"traceutil/trace.go:171","msg":"trace[2136114855] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2752; }","duration":"123.833319ms","start":"2026-05-22T19:08:14.086748Z","end":"2026-05-22T19:08:14.210581Z","steps":["trace[2136114855] 'agreement among raft nodes before linearized reading' (duration: 123.731267ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:08:14.210417Z","caller":"traceutil/trace.go:171","msg":"trace[1234244584] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"153.554427ms","start":"2026-05-22T19:08:14.05682Z","end":"2026-05-22T19:08:14.210375Z","steps":["trace[1234244584] 'process raft request' (duration: 129.597225ms)","trace[1234244584] 'compare' (duration: 23.683467ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:08:14.210762Z","caller":"traceutil/trace.go:171","msg":"trace[1010261790] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"153.359573ms","start":"2026-05-22T19:08:14.057186Z","end":"2026-05-22T19:08:14.210545Z","steps":["trace[1010261790] 'process raft request' (duration: 153.110028ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:12:13.504267Z","caller":"traceutil/trace.go:171","msg":"trace[455870416] linearizableReadLoop","detail":"{readStateIndex:5117; appliedIndex:5116; }","duration":"255.075462ms","start":"2026-05-22T19:12:13.249172Z","end":"2026-05-22T19:12:13.504247Z","steps":["trace[455870416] 'read index received' (duration: 215.273564ms)","trace[455870416] 'applied index is now lower than readState.Index' (duration: 39.801208ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:12:13.504387Z","caller":"traceutil/trace.go:171","msg":"trace[1389608031] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"309.435521ms","start":"2026-05-22T19:12:13.194933Z","end":"2026-05-22T19:12:13.504369Z","steps":["trace[1389608031] 'process raft request' (duration: 269.529871ms)","trace[1389608031] 'compare' (duration: 39.696786ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T19:12:13.504469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:12:13.194908Z","time spent":"309.497093ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T19:12:13.504723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.480109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-22T19:12:13.504836Z","caller":"traceutil/trace.go:171","msg":"trace[1700590388] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:4931; }","duration":"219.635493ms","start":"2026-05-22T19:12:13.285172Z","end":"2026-05-22T19:12:13.504808Z","steps":["trace[1700590388] 'agreement among raft nodes before linearized reading' (duration: 219.391758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:12:13.505338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.163284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T19:12:13.505374Z","caller":"traceutil/trace.go:171","msg":"trace[1945810434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4931; }","duration":"256.230726ms","start":"2026-05-22T19:12:13.249135Z","end":"2026-05-22T19:12:13.505366Z","steps":["trace[1945810434] 'agreement among raft nodes before linearized reading' (duration: 256.177064ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:12:27.223312Z","caller":"traceutil/trace.go:171","msg":"trace[1012018398] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"109.055696ms","start":"2026-05-22T19:12:27.114235Z","end":"2026-05-22T19:12:27.22329Z","steps":["trace[1012018398] 'process raft request' (duration: 108.721619ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:12:27.223351Z","caller":"traceutil/trace.go:171","msg":"trace[1784946045] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"108.945213ms","start":"2026-05-22T19:12:27.114376Z","end":"2026-05-22T19:12:27.223321Z","steps":["trace[1784946045] 'process raft request' (duration: 108.665318ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:12:27.223374Z","caller":"traceutil/trace.go:171","msg":"trace[959267565] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"109.371502ms","start":"2026-05-22T19:12:27.113976Z","end":"2026-05-22T19:12:27.223347Z","steps":["trace[959267565] 'process raft request' (duration: 41.097603ms)","trace[959267565] 'compare' (duration: 67.673547ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T19:12:27.645212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.766224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-22T19:12:27.645299Z","caller":"traceutil/trace.go:171","msg":"trace[1390163902] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:5193; }","duration":"215.891326ms","start":"2026-05-22T19:12:27.429388Z","end":"2026-05-22T19:12:27.645279Z","steps":["trace[1390163902] 'count revisions from in-memory index tree' (duration: 215.650392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:12:35.791168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.423045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T19:12:35.79156Z","caller":"traceutil/trace.go:171","msg":"trace[384272656] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"104.24765ms","start":"2026-05-22T19:12:35.687288Z","end":"2026-05-22T19:12:35.791536Z","steps":["trace[384272656] 'process raft request' (duration: 104.098927ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:12:35.791771Z","caller":"traceutil/trace.go:171","msg":"trace[1227597126] transaction","detail":"{read_only:false; response_revision:5374; number_of_response:1; }","duration":"225.279585ms","start":"2026-05-22T19:12:35.566458Z","end":"2026-05-22T19:12:35.791738Z","steps":["trace[1227597126] 'process raft request' (duration: 59.179656ms)","trace[1227597126] 'compare' (duration: 165.272562ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:12:35.847671Z","caller":"traceutil/trace.go:171","msg":"trace[1201217930] transaction","detail":"{read_only:false; response_revision:5376; number_of_response:1; }","duration":"143.054887ms","start":"2026-05-22T19:12:35.704596Z","end":"2026-05-22T19:12:35.847651Z","steps":["trace[1201217930] 'process raft request' (duration: 142.636529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:12:36.052853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.051798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T19:12:36.053108Z","caller":"traceutil/trace.go:171","msg":"trace[1581418550] transaction","detail":"{read_only:false; response_revision:5379; number_of_response:1; }","duration":"199.976778ms","start":"2026-05-22T19:12:35.853105Z","end":"2026-05-22T19:12:36.053081Z","steps":["trace[1581418550] 'process raft request' (duration: 199.869456ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:12:36.053296Z","caller":"traceutil/trace.go:171","msg":"trace[365005024] transaction","detail":"{read_only:false; response_revision:5378; number_of_response:1; }","duration":"200.248604ms","start":"2026-05-22T19:12:35.853035Z","end":"2026-05-22T19:12:36.053283Z","steps":["trace[365005024] 'process raft request' (duration: 41.665505ms)","trace[365005024] 'compare' (duration: 157.844403ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:13:52.573315Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2961} {"level":"info","ts":"2026-05-22T19:13:52.643625Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2961,"took":"68.697416ms","hash":943098671,"current-db-size-bytes":59072512,"current-db-size":"59 MB","current-db-size-in-use-bytes":33906688,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-22T19:13:52.643747Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":943098671,"revision":2961,"compact-revision":-1} {"level":"info","ts":"2026-05-22T19:18:41.413211Z","caller":"traceutil/trace.go:171","msg":"trace[1405055253] linearizableReadLoop","detail":"{readStateIndex:8477; appliedIndex:8476; }","duration":"160.996234ms","start":"2026-05-22T19:18:41.25219Z","end":"2026-05-22T19:18:41.413187Z","steps":["trace[1405055253] 'read index received' (duration: 160.758289ms)","trace[1405055253] 'applied index is now lower than readState.Index' (duration: 237.045µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:18:41.413252Z","caller":"traceutil/trace.go:171","msg":"trace[1153515359] transaction","detail":"{read_only:false; response_revision:8189; number_of_response:1; }","duration":"216.735454ms","start":"2026-05-22T19:18:41.196481Z","end":"2026-05-22T19:18:41.413217Z","steps":["trace[1153515359] 'process raft request' (duration: 216.54585ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:18:41.413332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.126186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T19:18:41.413363Z","caller":"traceutil/trace.go:171","msg":"trace[245432344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8189; }","duration":"161.207538ms","start":"2026-05-22T19:18:41.252146Z","end":"2026-05-22T19:18:41.413354Z","steps":["trace[245432344] 'agreement among raft nodes before linearized reading' (duration: 161.142167ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:18:41.586244Z","caller":"traceutil/trace.go:171","msg":"trace[831631942] transaction","detail":"{read_only:false; response_revision:8190; number_of_response:1; }","duration":"142.37927ms","start":"2026-05-22T19:18:41.443839Z","end":"2026-05-22T19:18:41.586218Z","steps":["trace[831631942] 'process raft request' (duration: 142.224227ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:18:52.620317Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6083} {"level":"info","ts":"2026-05-22T19:18:53.272407Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6083,"took":"649.742432ms","hash":377785469,"current-db-size-bytes":59072512,"current-db-size":"59 MB","current-db-size-in-use-bytes":23191552,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-05-22T19:18:53.272511Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":377785469,"revision":6083,"compact-revision":2961} {"level":"warn","ts":"2026-05-22T19:18:53.923978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.639303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-22T19:18:53.924063Z","caller":"traceutil/trace.go:171","msg":"trace[1357069448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8255; }","duration":"222.774405ms","start":"2026-05-22T19:18:53.70127Z","end":"2026-05-22T19:18:53.924045Z","steps":["trace[1357069448] 'range keys from in-memory index tree' (duration: 222.392478ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:18:53.929347Z","caller":"traceutil/trace.go:171","msg":"trace[866004179] linearizableReadLoop","detail":"{readStateIndex:8547; appliedIndex:8546; }","duration":"117.730075ms","start":"2026-05-22T19:18:53.811596Z","end":"2026-05-22T19:18:53.929326Z","steps":["trace[866004179] 'read index received' (duration: 117.650113ms)","trace[866004179] 'applied index is now lower than readState.Index' (duration: 78.922µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:18:53.929392Z","caller":"traceutil/trace.go:171","msg":"trace[231659975] transaction","detail":"{read_only:false; response_revision:8256; number_of_response:1; }","duration":"183.7201ms","start":"2026-05-22T19:18:53.745645Z","end":"2026-05-22T19:18:53.929365Z","steps":["trace[231659975] 'process raft request' (duration: 183.535847ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:18:53.929603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.989679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-22T19:18:53.929684Z","caller":"traceutil/trace.go:171","msg":"trace[192121588] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8256; }","duration":"118.121572ms","start":"2026-05-22T19:18:53.811543Z","end":"2026-05-22T19:18:53.929665Z","steps":["trace[192121588] 'agreement among raft nodes before linearized reading' (duration: 117.893928ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:18:53.974233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.105265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-22T19:18:53.974295Z","caller":"traceutil/trace.go:171","msg":"trace[769759690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8258; }","duration":"151.220038ms","start":"2026-05-22T19:18:53.823061Z","end":"2026-05-22T19:18:53.974281Z","steps":["trace[769759690] 'agreement among raft nodes before linearized reading' (duration: 151.055014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:18:53.974656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.327739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:122781"} {"level":"info","ts":"2026-05-22T19:18:53.974718Z","caller":"traceutil/trace.go:171","msg":"trace[32671262] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:8258; }","duration":"130.3973ms","start":"2026-05-22T19:18:53.844307Z","end":"2026-05-22T19:18:53.974705Z","steps":["trace[32671262] 'agreement among raft nodes before linearized reading' (duration: 130.238677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:18:53.97481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.606074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-05-22T19:18:53.974839Z","caller":"traceutil/trace.go:171","msg":"trace[1832072054] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:8258; }","duration":"134.673985ms","start":"2026-05-22T19:18:53.840159Z","end":"2026-05-22T19:18:53.974833Z","steps":["trace[1832072054] 'agreement among raft nodes before linearized reading' (duration: 134.600034ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:19:34.584097Z","caller":"traceutil/trace.go:171","msg":"trace[1459102059] transaction","detail":"{read_only:false; response_revision:8572; number_of_response:1; }","duration":"170.165438ms","start":"2026-05-22T19:19:34.413907Z","end":"2026-05-22T19:19:34.584072Z","steps":["trace[1459102059] 'process raft request' (duration: 169.898163ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:19:34.787275Z","caller":"traceutil/trace.go:171","msg":"trace[1509821877] transaction","detail":"{read_only:false; response_revision:8573; number_of_response:1; }","duration":"252.707697ms","start":"2026-05-22T19:19:34.534544Z","end":"2026-05-22T19:19:34.787252Z","steps":["trace[1509821877] 'process raft request' (duration: 252.555734ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:19:34.975299Z","caller":"traceutil/trace.go:171","msg":"trace[1977195042] transaction","detail":"{read_only:false; response_revision:8574; number_of_response:1; }","duration":"382.80541ms","start":"2026-05-22T19:19:34.592457Z","end":"2026-05-22T19:19:34.975262Z","steps":["trace[1977195042] 'process raft request' (duration: 292.322562ms)","trace[1977195042] 'compare' (duration: 90.351596ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:19:34.975337Z","caller":"traceutil/trace.go:171","msg":"trace[1910011359] transaction","detail":"{read_only:false; response_revision:8575; number_of_response:1; }","duration":"152.160277ms","start":"2026-05-22T19:19:34.823153Z","end":"2026-05-22T19:19:34.975313Z","steps":["trace[1910011359] 'process raft request' (duration: 152.101896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:19:34.975477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:19:34.592435Z","time spent":"382.947413ms","remote":"127.0.0.1:55136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4630,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T19:19:34.975616Z","caller":"traceutil/trace.go:171","msg":"trace[1373714259] linearizableReadLoop","detail":"{readStateIndex:8878; appliedIndex:8877; }","duration":"174.874913ms","start":"2026-05-22T19:19:34.800726Z","end":"2026-05-22T19:19:34.9756Z","steps":["trace[1373714259] 'read index received' (duration: 84.064318ms)","trace[1373714259] 'applied index is now lower than readState.Index' (duration: 90.808645ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T19:19:34.975883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.294158ms","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-05-22T19:19:34.975957Z","caller":"traceutil/trace.go:171","msg":"trace[1896535138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8575; }","duration":"140.38756ms","start":"2026-05-22T19:19:34.835553Z","end":"2026-05-22T19:19:34.975941Z","steps":["trace[1896535138] 'agreement among raft nodes before linearized reading' (duration: 140.176855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:19:34.97588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.132719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-64cbc8d694-jmx5h.18b1f95f2367cb1b\" ","response":"range_response_count:1 size:1133"} {"level":"info","ts":"2026-05-22T19:19:34.976099Z","caller":"traceutil/trace.go:171","msg":"trace[314801756] range","detail":"{range_begin:/registry/events/openstack/barbican-api-64cbc8d694-jmx5h.18b1f95f2367cb1b; range_end:; response_count:1; response_revision:8575; }","duration":"175.392924ms","start":"2026-05-22T19:19:34.800667Z","end":"2026-05-22T19:19:34.97606Z","steps":["trace[314801756] 'agreement among raft nodes before linearized reading' (duration: 175.016577ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:19:35.580888Z","caller":"traceutil/trace.go:171","msg":"trace[1250513251] transaction","detail":"{read_only:false; response_revision:8580; number_of_response:1; }","duration":"105.54835ms","start":"2026-05-22T19:19:35.475307Z","end":"2026-05-22T19:19:35.580855Z","steps":["trace[1250513251] 'process raft request' (duration: 73.038607ms)","trace[1250513251] 'compare' (duration: 32.33914ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T19:19:35.954928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.296909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"} {"level":"info","ts":"2026-05-22T19:19:35.955027Z","caller":"traceutil/trace.go:171","msg":"trace[139119235] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8582; }","duration":"271.414122ms","start":"2026-05-22T19:19:35.683589Z","end":"2026-05-22T19:19:35.955003Z","steps":["trace[139119235] 'range keys from in-memory index tree' (duration: 271.081574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:19:35.955174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.198999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:111895"} {"level":"info","ts":"2026-05-22T19:19:35.955302Z","caller":"traceutil/trace.go:171","msg":"trace[1319726535] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:8582; }","duration":"272.388543ms","start":"2026-05-22T19:19:35.682895Z","end":"2026-05-22T19:19:35.955283Z","steps":["trace[1319726535] 'range keys from in-memory index tree' (duration: 271.852931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:19:35.95631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.177784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224949"} {"level":"info","ts":"2026-05-22T19:19:35.956388Z","caller":"traceutil/trace.go:171","msg":"trace[1625434413] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8582; }","duration":"130.303858ms","start":"2026-05-22T19:19:35.826067Z","end":"2026-05-22T19:19:35.956371Z","steps":["trace[1625434413] 'range keys from in-memory index tree' (duration: 128.829078ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:20:11.235014Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002411.wal"} {"level":"warn","ts":"2026-05-22T19:20:54.616298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.705805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-22T19:20:54.616407Z","caller":"traceutil/trace.go:171","msg":"trace[1513529920] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:9337; }","duration":"121.443499ms","start":"2026-05-22T19:20:54.494936Z","end":"2026-05-22T19:20:54.61638Z","steps":["trace[1513529920] 'range keys from in-memory index tree' (duration: 120.428159ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:21:39.595069Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"66f7b57d56ad567d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-22T19:21:39.604872Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-22T19:21:39.604961Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-22T19:23:52.628049Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8253} {"level":"info","ts":"2026-05-22T19:23:52.706497Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8253,"took":"76.063145ms","hash":3815298862,"current-db-size-bytes":59072512,"current-db-size":"59 MB","current-db-size-in-use-bytes":25481216,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-22T19:23:52.706577Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3815298862,"revision":8253,"compact-revision":6083} {"level":"info","ts":"2026-05-22T19:24:13.770156Z","caller":"traceutil/trace.go:171","msg":"trace[936275347] transaction","detail":"{read_only:false; response_revision:11051; number_of_response:1; }","duration":"112.375169ms","start":"2026-05-22T19:24:13.657753Z","end":"2026-05-22T19:24:13.770128Z","steps":["trace[936275347] 'process raft request' (duration: 95.939097ms)","trace[936275347] 'compare' (duration: 16.215488ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:24:13.770908Z","caller":"traceutil/trace.go:171","msg":"trace[551711447] transaction","detail":"{read_only:false; response_revision:11052; number_of_response:1; }","duration":"113.063872ms","start":"2026-05-22T19:24:13.657815Z","end":"2026-05-22T19:24:13.770878Z","steps":["trace[551711447] 'process raft request' (duration: 112.253466ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:24:13.770941Z","caller":"traceutil/trace.go:171","msg":"trace[926302006] transaction","detail":"{read_only:false; response_revision:11053; number_of_response:1; }","duration":"112.841158ms","start":"2026-05-22T19:24:13.658076Z","end":"2026-05-22T19:24:13.770917Z","steps":["trace[926302006] 'process raft request' (duration: 112.717455ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:24:30.982593Z","caller":"traceutil/trace.go:171","msg":"trace[1146950795] transaction","detail":"{read_only:false; response_revision:11147; number_of_response:1; }","duration":"281.591145ms","start":"2026-05-22T19:24:30.70097Z","end":"2026-05-22T19:24:30.982562Z","steps":["trace[1146950795] 'process raft request' (duration: 281.432362ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:28:52.63404Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10752} {"level":"info","ts":"2026-05-22T19:28:52.712239Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10752,"took":"75.920496ms","hash":4033676711,"current-db-size-bytes":59072512,"current-db-size":"59 MB","current-db-size-in-use-bytes":28008448,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-22T19:28:52.712292Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4033676711,"revision":10752,"compact-revision":8253} {"level":"info","ts":"2026-05-22T19:30:28.262186Z","caller":"traceutil/trace.go:171","msg":"trace[501784754] transaction","detail":"{read_only:false; response_revision:13579; number_of_response:1; }","duration":"100.828299ms","start":"2026-05-22T19:30:28.16132Z","end":"2026-05-22T19:30:28.262148Z","steps":["trace[501784754] 'process raft request' (duration: 100.610805ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:30:31.323438Z","caller":"traceutil/trace.go:171","msg":"trace[514078599] transaction","detail":"{read_only:false; response_revision:13595; number_of_response:1; }","duration":"126.090857ms","start":"2026-05-22T19:30:31.197301Z","end":"2026-05-22T19:30:31.323392Z","steps":["trace[514078599] 'process raft request' (duration: 125.893442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:30:50.681364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.741809ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T19:30:50.681481Z","caller":"traceutil/trace.go:171","msg":"trace[1517315297] linearizableReadLoop","detail":"{readStateIndex:14168; appliedIndex:14167; }","duration":"164.150234ms","start":"2026-05-22T19:30:50.517314Z","end":"2026-05-22T19:30:50.681464Z","steps":["trace[1517315297] 'read index received' (duration: 55.262943ms)","trace[1517315297] 'applied index is now lower than readState.Index' (duration: 108.886251ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T19:30:50.681664Z","caller":"traceutil/trace.go:171","msg":"trace[572091630] transaction","detail":"{read_only:false; response_revision:13701; number_of_response:1; }","duration":"198.293381ms","start":"2026-05-22T19:30:50.48336Z","end":"2026-05-22T19:30:50.681653Z","steps":["trace[572091630] 'process raft request' (duration: 89.160825ms)","trace[572091630] 'compare' (duration: 108.133145ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T19:30:50.681688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.355998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-05-22T19:30:50.681784Z","caller":"traceutil/trace.go:171","msg":"trace[1995804961] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:13701; }","duration":"164.533531ms","start":"2026-05-22T19:30:50.517229Z","end":"2026-05-22T19:30:50.681763Z","steps":["trace[1995804961] 'agreement among raft nodes before linearized reading' (duration: 164.277336ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:31:06.298098Z","caller":"traceutil/trace.go:171","msg":"trace[1347789200] transaction","detail":"{read_only:false; response_revision:13796; number_of_response:1; }","duration":"116.663698ms","start":"2026-05-22T19:31:06.181399Z","end":"2026-05-22T19:31:06.298063Z","steps":["trace[1347789200] 'process raft request' (duration: 116.366462ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:31:07.076978Z","caller":"traceutil/trace.go:171","msg":"trace[950021738] transaction","detail":"{read_only:false; response_revision:13799; number_of_response:1; }","duration":"340.95129ms","start":"2026-05-22T19:31:06.735997Z","end":"2026-05-22T19:31:07.076948Z","steps":["trace[950021738] 'process raft request' (duration: 340.740186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:31:07.07716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:31:06.735972Z","time spent":"341.091474ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T19:31:07.077561Z","caller":"traceutil/trace.go:171","msg":"trace[425419856] transaction","detail":"{read_only:false; response_revision:13800; number_of_response:1; }","duration":"339.747818ms","start":"2026-05-22T19:31:06.737802Z","end":"2026-05-22T19:31:07.077549Z","steps":["trace[425419856] 'process raft request' (duration: 339.684587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:31:07.077634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T19:31:06.737782Z","time spent":"339.815289ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T19:31:16.145959Z","caller":"traceutil/trace.go:171","msg":"trace[1191914800] transaction","detail":"{read_only:false; response_revision:13967; number_of_response:1; }","duration":"171.176725ms","start":"2026-05-22T19:31:15.97476Z","end":"2026-05-22T19:31:16.145937Z","steps":["trace[1191914800] 'process raft request' (duration: 170.844058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:32:55.244658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.193609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-2n7lg\" ","response":"range_response_count:1 size:6516"} {"level":"info","ts":"2026-05-22T19:32:55.244816Z","caller":"traceutil/trace.go:171","msg":"trace[1653700550] range","detail":"{range_begin:/registry/pods/openstack/keepalived-2n7lg; range_end:; response_count:1; response_revision:15050; }","duration":"118.421153ms","start":"2026-05-22T19:32:55.126366Z","end":"2026-05-22T19:32:55.244787Z","steps":["trace[1653700550] 'range keys from in-memory index tree' (duration: 117.949663ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:33:52.639714Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12922} {"level":"info","ts":"2026-05-22T19:33:52.718113Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12922,"took":"75.458029ms","hash":142227486,"current-db-size-bytes":59072512,"current-db-size":"59 MB","current-db-size-in-use-bytes":29868032,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-22T19:33:52.718171Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":142227486,"revision":12922,"compact-revision":10752} {"level":"info","ts":"2026-05-22T19:38:33.084192Z","caller":"traceutil/trace.go:171","msg":"trace[1344424225] transaction","detail":"{read_only:false; response_revision:17555; number_of_response:1; }","duration":"108.080664ms","start":"2026-05-22T19:38:32.976078Z","end":"2026-05-22T19:38:33.084158Z","steps":["trace[1344424225] 'process raft request' (duration: 107.88151ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:38:38.822754Z","caller":"traceutil/trace.go:171","msg":"trace[1683059991] transaction","detail":"{read_only:false; response_revision:17589; number_of_response:1; }","duration":"142.61048ms","start":"2026-05-22T19:38:38.680113Z","end":"2026-05-22T19:38:38.822724Z","steps":["trace[1683059991] 'process raft request' (duration: 83.594652ms)","trace[1683059991] 'compare' (duration: 58.895706ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T19:38:39.370628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.393221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-22T19:38:39.370725Z","caller":"traceutil/trace.go:171","msg":"trace[926262867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17593; }","duration":"118.543615ms","start":"2026-05-22T19:38:39.252163Z","end":"2026-05-22T19:38:39.370706Z","steps":["trace[926262867] 'range keys from in-memory index tree' (duration: 118.31377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:38:39.370775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.444811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-22T19:38:39.370887Z","caller":"traceutil/trace.go:171","msg":"trace[378909341] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:17593; }","duration":"101.621635ms","start":"2026-05-22T19:38:39.269241Z","end":"2026-05-22T19:38:39.370862Z","steps":["trace[378909341] 'count revisions from in-memory index tree' (duration: 101.363439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:38:39.370909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.118833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"} {"level":"info","ts":"2026-05-22T19:38:39.370991Z","caller":"traceutil/trace.go:171","msg":"trace[131051619] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17593; }","duration":"174.263906ms","start":"2026-05-22T19:38:39.196711Z","end":"2026-05-22T19:38:39.370975Z","steps":["trace[131051619] 'range keys from in-memory index tree' (duration: 173.903739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:38:39.371085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.369753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-22T19:38:39.371283Z","caller":"traceutil/trace.go:171","msg":"trace[1023742258] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:17593; }","duration":"138.584728ms","start":"2026-05-22T19:38:39.232672Z","end":"2026-05-22T19:38:39.371256Z","steps":["trace[1023742258] 'count revisions from in-memory index tree' (duration: 138.290522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T19:38:39.371361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.343027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-kpwnw\" ","response":"range_response_count:1 size:22086"} {"level":"info","ts":"2026-05-22T19:38:39.372062Z","caller":"traceutil/trace.go:171","msg":"trace[1340400522] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-kpwnw; range_end:; response_count:1; response_revision:17593; }","duration":"168.098812ms","start":"2026-05-22T19:38:39.203941Z","end":"2026-05-22T19:38:39.372039Z","steps":["trace[1340400522] 'range keys from in-memory index tree' (duration: 167.02657ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:38:39.839379Z","caller":"traceutil/trace.go:171","msg":"trace[1752034904] transaction","detail":"{read_only:false; response_revision:17594; number_of_response:1; }","duration":"126.951814ms","start":"2026-05-22T19:38:39.712399Z","end":"2026-05-22T19:38:39.839351Z","steps":["trace[1752034904] 'process raft request' (duration: 126.777521ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T19:38:52.645667Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15411} {"level":"info","ts":"2026-05-22T19:38:52.742528Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15411,"took":"91.848958ms","hash":678909951,"current-db-size-bytes":59072512,"current-db-size":"59 MB","current-db-size-in-use-bytes":31137792,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-22T19:38:52.74261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":678909951,"revision":15411,"compact-revision":12922} {"level":"info","ts":"2026-05-22T19:43:52.650977Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17736} {"level":"info","ts":"2026-05-22T19:43:52.744725Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17736,"took":"90.541949ms","hash":2159423000,"current-db-size-bytes":59072512,"current-db-size":"59 MB","current-db-size-in-use-bytes":26701824,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-22T19:43:52.744802Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2159423000,"revision":17736,"compact-revision":15411} {"level":"info","ts":"2026-05-22T19:43:57.947919Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"66f7b57d56ad567d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-22T19:43:57.953631Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-22T19:43:57.953793Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}