{"level":"warn","ts":"2026-05-16T01:17:30.653944Z","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-16T01:17:30.65405Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-16T01:17:30.654374Z","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-16T01:17:30.654419Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-16T01:17:30.654452Z","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-16T01:17:30.65814Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-05-16T01:17:30.658268Z","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.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-16T01:17:30.664942Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.319974ms"} {"level":"info","ts":"2026-05-16T01:17:30.675371Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-05-16T01:17:30.675451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-05-16T01:17:30.675471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-05-16T01:17:30.675481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-16T01:17:30.67549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-05-16T01:17:30.675527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-05-16T01:17:30.685945Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-16T01:17:30.688495Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-16T01:17:30.689632Z","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-16T01:17:30.691663Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-16T01:17:30.692429Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-16T01:17:30.692681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-05-16T01:17:30.692803Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-16T01:17:30.692877Z","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-16T01:17:30.692908Z","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-16T01:17:30.692928Z","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-16T01:17:30.701468Z","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-16T01:17:30.701608Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-16T01:17:30.70166Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-16T01:17:30.701984Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-16T01:17:30.702072Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-16T01:17:31.076436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-05-16T01:17:31.076499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-16T01:17:31.076548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-05-16T01:17:31.076574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-05-16T01:17:31.076591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-16T01:17:31.076607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-05-16T01:17:31.076628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-16T01:17:31.077789Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-16T01:17:31.077836Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-16T01:17:31.078246Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-16T01:17:31.078496Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-16T01:17:31.078831Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-16T01:17:31.078893Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-16T01:17:31.079226Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-05-16T01:17:31.079316Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-16T01:17:31.079373Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-16T01:17:31.082536Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-05-16T01:17:31.082796Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-16T01:17:41.439016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.71999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-16T01:17:41.439125Z","caller":"traceutil/trace.go:171","msg":"trace[275816631] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"214.057979ms","start":"2026-05-16T01:17:41.225054Z","end":"2026-05-16T01:17:41.439112Z","steps":["trace[275816631] 'process raft request' (duration: 59.756394ms)","trace[275816631] 'compare' (duration: 153.591338ms)"],"step_count":2} {"level":"warn","ts":"2026-05-16T01:17:48.868647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.542811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-16T01:17:48.868742Z","caller":"traceutil/trace.go:171","msg":"trace[642185444] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:407; }","duration":"126.687632ms","start":"2026-05-16T01:17:48.742032Z","end":"2026-05-16T01:17:48.86872Z","steps":["trace[642185444] 'range keys from in-memory index tree' (duration: 126.462011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:17:48.868749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.178285ms","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-16T01:17:48.868836Z","caller":"traceutil/trace.go:171","msg":"trace[1833720777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:407; }","duration":"160.286986ms","start":"2026-05-16T01:17:48.708528Z","end":"2026-05-16T01:17:48.868815Z","steps":["trace[1833720777] 'range keys from in-memory index tree' (duration: 160.023214ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:18:06.918323Z","caller":"traceutil/trace.go:171","msg":"trace[1113919912] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"173.631007ms","start":"2026-05-16T01:18:06.744666Z","end":"2026-05-16T01:18:06.918297Z","steps":["trace[1113919912] 'read index received' (duration: 172.852787ms)","trace[1113919912] 'applied index is now lower than readState.Index' (duration: 777.22µs)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:18:06.918413Z","caller":"traceutil/trace.go:171","msg":"trace[825061762] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"343.935217ms","start":"2026-05-16T01:18:06.574458Z","end":"2026-05-16T01:18:06.918393Z","steps":["trace[825061762] 'process raft request' (duration: 343.309535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:18:06.91857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.418088ms","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-16T01:18:06.918607Z","caller":"traceutil/trace.go:171","msg":"trace[469266668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:574; }","duration":"125.502382ms","start":"2026-05-16T01:18:06.793091Z","end":"2026-05-16T01:18:06.918593Z","steps":["trace[469266668] 'agreement among raft nodes before linearized reading' (duration: 125.350834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:18:06.918651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:18:06.574436Z","time spent":"344.054433ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-16T01:18:06.918613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.882509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-16T01:18:06.918834Z","caller":"traceutil/trace.go:171","msg":"trace[182821222] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:574; }","duration":"174.1031ms","start":"2026-05-16T01:18:06.744623Z","end":"2026-05-16T01:18:06.918726Z","steps":["trace[182821222] 'agreement among raft nodes before linearized reading' (duration: 173.820466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:18:07.618212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.038162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9dqgn\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-16T01:18:07.61832Z","caller":"traceutil/trace.go:171","msg":"trace[639273940] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9dqgn; range_end:; response_count:1; response_revision:578; }","duration":"481.19412ms","start":"2026-05-16T01:18:07.137099Z","end":"2026-05-16T01:18:07.618293Z","steps":["trace[639273940] 'range keys from in-memory index tree' (duration: 480.930258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:18:07.618372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:18:07.137079Z","time spent":"481.279184ms","remote":"127.0.0.1:32832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-9dqgn\" "} {"level":"info","ts":"2026-05-16T01:18:07.620426Z","caller":"traceutil/trace.go:171","msg":"trace[800300675] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"190.643404ms","start":"2026-05-16T01:18:07.429764Z","end":"2026-05-16T01:18:07.620408Z","steps":["trace[800300675] 'process raft request' (duration: 189.802213ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:18:23.281464Z","caller":"traceutil/trace.go:171","msg":"trace[1068464078] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"149.486151ms","start":"2026-05-16T01:18:23.131957Z","end":"2026-05-16T01:18:23.281443Z","steps":["trace[1068464078] 'process raft request' (duration: 149.357356ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:18:23.291968Z","caller":"traceutil/trace.go:171","msg":"trace[336413731] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"159.883767ms","start":"2026-05-16T01:18:23.132068Z","end":"2026-05-16T01:18:23.291951Z","steps":["trace[336413731] 'process raft request' (duration: 159.649318ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:19:41.787655Z","caller":"traceutil/trace.go:171","msg":"trace[1661819948] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"175.211637ms","start":"2026-05-16T01:19:41.612418Z","end":"2026-05-16T01:19:41.78763Z","steps":["trace[1661819948] 'process raft request' (duration: 174.620824ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:19:41.975668Z","caller":"traceutil/trace.go:171","msg":"trace[1332469911] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"180.528247ms","start":"2026-05-16T01:19:41.795087Z","end":"2026-05-16T01:19:41.975615Z","steps":["trace[1332469911] 'process raft request' (duration: 156.956831ms)","trace[1332469911] 'compare' (duration: 23.126397ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:19:41.975974Z","caller":"traceutil/trace.go:171","msg":"trace[1850800509] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"180.756551ms","start":"2026-05-16T01:19:41.795161Z","end":"2026-05-16T01:19:41.975918Z","steps":["trace[1850800509] 'process raft request' (duration: 180.410464ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:19:41.976043Z","caller":"traceutil/trace.go:171","msg":"trace[2129081875] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"180.856943ms","start":"2026-05-16T01:19:41.795166Z","end":"2026-05-16T01:19:41.976023Z","steps":["trace[2129081875] 'process raft request' (duration: 180.312242ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:19:41.976033Z","caller":"traceutil/trace.go:171","msg":"trace[243966565] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1898; }","duration":"180.610138ms","start":"2026-05-16T01:19:41.795353Z","end":"2026-05-16T01:19:41.975963Z","steps":["trace[243966565] 'read index received' (duration: 52.097122ms)","trace[243966565] 'applied index is now lower than readState.Index' (duration: 128.511536ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:19:41.976283Z","caller":"traceutil/trace.go:171","msg":"trace[1297988065] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"177.934473ms","start":"2026-05-16T01:19:41.798332Z","end":"2026-05-16T01:19:41.976266Z","steps":["trace[1297988065] 'process raft request' (duration: 177.403932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:19:41.976654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.554463ms","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-05-16T01:19:41.976704Z","caller":"traceutil/trace.go:171","msg":"trace[752492091] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1827; }","duration":"174.643924ms","start":"2026-05-16T01:19:41.802047Z","end":"2026-05-16T01:19:41.976691Z","steps":["trace[752492091] 'agreement among raft nodes before linearized reading' (duration: 174.394669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:19:41.976681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.288441ms","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-16T01:19:41.976758Z","caller":"traceutil/trace.go:171","msg":"trace[1781333475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1827; }","duration":"181.403574ms","start":"2026-05-16T01:19:41.795336Z","end":"2026-05-16T01:19:41.976739Z","steps":["trace[1781333475] 'agreement among raft nodes before linearized reading' (duration: 181.046767ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:19:41.976074Z","caller":"traceutil/trace.go:171","msg":"trace[448767345] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"178.824161ms","start":"2026-05-16T01:19:41.797229Z","end":"2026-05-16T01:19:41.976053Z","steps":["trace[448767345] 'process raft request' (duration: 178.440604ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:19:54.220343Z","caller":"traceutil/trace.go:171","msg":"trace[1728133434] linearizableReadLoop","detail":"{readStateIndex:2005; appliedIndex:2004; }","duration":"147.905013ms","start":"2026-05-16T01:19:54.072423Z","end":"2026-05-16T01:19:54.220328Z","steps":["trace[1728133434] 'read index received' (duration: 147.799501ms)","trace[1728133434] 'applied index is now lower than readState.Index' (duration: 104.922µs)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:19:54.220428Z","caller":"traceutil/trace.go:171","msg":"trace[468224493] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"162.471789ms","start":"2026-05-16T01:19:54.057906Z","end":"2026-05-16T01:19:54.220378Z","steps":["trace[468224493] 'process raft request' (duration: 162.317946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:19:54.220509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.080546ms","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-05-16T01:19:54.220534Z","caller":"traceutil/trace.go:171","msg":"trace[1416913312] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1925; }","duration":"148.156788ms","start":"2026-05-16T01:19:54.072369Z","end":"2026-05-16T01:19:54.220526Z","steps":["trace[1416913312] 'agreement among raft nodes before linearized reading' (duration: 148.049736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:19:54.220552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.448071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-16T01:19:54.220606Z","caller":"traceutil/trace.go:171","msg":"trace[919599099] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:1925; }","duration":"120.530762ms","start":"2026-05-16T01:19:54.10006Z","end":"2026-05-16T01:19:54.220591Z","steps":["trace[919599099] 'agreement among raft nodes before linearized reading' (duration: 120.390399ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:20:15.909849Z","caller":"traceutil/trace.go:171","msg":"trace[151429431] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"129.45896ms","start":"2026-05-16T01:20:15.780366Z","end":"2026-05-16T01:20:15.909824Z","steps":["trace[151429431] 'process raft request' (duration: 129.293467ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:20:16.467445Z","caller":"traceutil/trace.go:171","msg":"trace[178609546] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"127.708969ms","start":"2026-05-16T01:20:16.339715Z","end":"2026-05-16T01:20:16.467424Z","steps":["trace[178609546] 'process raft request' (duration: 127.577707ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:20:16.494386Z","caller":"traceutil/trace.go:171","msg":"trace[1309899160] linearizableReadLoop","detail":"{readStateIndex:2151; appliedIndex:2149; }","duration":"128.396601ms","start":"2026-05-16T01:20:16.365964Z","end":"2026-05-16T01:20:16.494361Z","steps":["trace[1309899160] 'read index received' (duration: 101.308481ms)","trace[1309899160] 'applied index is now lower than readState.Index' (duration: 27.08721ms)"],"step_count":2} {"level":"warn","ts":"2026-05-16T01:20:16.494635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.658646ms","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-05-16T01:20:16.494671Z","caller":"traceutil/trace.go:171","msg":"trace[1120549848] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2066; }","duration":"128.744577ms","start":"2026-05-16T01:20:16.365913Z","end":"2026-05-16T01:20:16.494658Z","steps":["trace[1120549848] 'agreement among raft nodes before linearized reading' (duration: 128.542174ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:20:16.494686Z","caller":"traceutil/trace.go:171","msg":"trace[457192122] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"154.396463ms","start":"2026-05-16T01:20:16.340262Z","end":"2026-05-16T01:20:16.494658Z","steps":["trace[457192122] 'process raft request' (duration: 153.964766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:20:17.03787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.104837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-16T01:20:17.038518Z","caller":"traceutil/trace.go:171","msg":"trace[1463820605] linearizableReadLoop","detail":"{readStateIndex:2154; appliedIndex:2152; }","duration":"219.834801ms","start":"2026-05-16T01:20:16.818664Z","end":"2026-05-16T01:20:17.038499Z","steps":["trace[1463820605] 'read index received' (duration: 92.042162ms)","trace[1463820605] 'applied index is now lower than readState.Index' (duration: 127.791599ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:20:17.038706Z","caller":"traceutil/trace.go:171","msg":"trace[1065875965] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"272.406645ms","start":"2026-05-16T01:20:16.766251Z","end":"2026-05-16T01:20:17.038658Z","steps":["trace[1065875965] 'process raft request' (duration: 272.11667ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:20:17.038736Z","caller":"traceutil/trace.go:171","msg":"trace[740946345] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"280.164357ms","start":"2026-05-16T01:20:16.758544Z","end":"2026-05-16T01:20:17.038709Z","steps":["trace[740946345] 'process raft request' (duration: 152.123424ms)","trace[740946345] 'compare' (duration: 126.926114ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:20:17.038708Z","caller":"traceutil/trace.go:171","msg":"trace[1322864734] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"203.529135ms","start":"2026-05-16T01:20:16.835148Z","end":"2026-05-16T01:20:17.038678Z","steps":["trace[1322864734] 'process raft request' (duration: 203.312522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:20:17.038779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.780019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-16T01:20:17.038825Z","caller":"traceutil/trace.go:171","msg":"trace[406020501] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2070; }","duration":"173.880551ms","start":"2026-05-16T01:20:16.864934Z","end":"2026-05-16T01:20:17.038815Z","steps":["trace[406020501] 'agreement among raft nodes before linearized reading' (duration: 173.739879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:20:17.038902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.213148ms","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-16T01:20:17.038984Z","caller":"traceutil/trace.go:171","msg":"trace[951704499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2070; }","duration":"220.379241ms","start":"2026-05-16T01:20:16.818586Z","end":"2026-05-16T01:20:17.038965Z","steps":["trace[951704499] 'agreement among raft nodes before linearized reading' (duration: 220.076336ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:20:17.294556Z","caller":"traceutil/trace.go:171","msg":"trace[1668864533] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"112.90455ms","start":"2026-05-16T01:20:17.181595Z","end":"2026-05-16T01:20:17.294499Z","steps":["trace[1668864533] 'process raft request' (duration: 54.666996ms)","trace[1668864533] 'compare' (duration: 58.054561ms)"],"step_count":2} {"level":"warn","ts":"2026-05-16T01:21:59.782986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.479134ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-16T01:21:59.783136Z","caller":"traceutil/trace.go:171","msg":"trace[1710405498] linearizableReadLoop","detail":"{readStateIndex:2835; appliedIndex:2834; }","duration":"230.202528ms","start":"2026-05-16T01:21:59.552918Z","end":"2026-05-16T01:21:59.783121Z","steps":["trace[1710405498] 'read index received' (duration: 65.25µs)","trace[1710405498] 'applied index is now lower than readState.Index' (duration: 230.084007ms)"],"step_count":2} {"level":"warn","ts":"2026-05-16T01:21:59.783365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.439781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-16T01:21:59.783386Z","caller":"traceutil/trace.go:171","msg":"trace[1023491348] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2726; }","duration":"230.517602ms","start":"2026-05-16T01:21:59.552863Z","end":"2026-05-16T01:21:59.78338Z","steps":["trace[1023491348] 'agreement among raft nodes before linearized reading' (duration: 230.34042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:21:59.788991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.323709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-16T01:21:59.78908Z","caller":"traceutil/trace.go:171","msg":"trace[1187179674] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2727; }","duration":"155.467971ms","start":"2026-05-16T01:21:59.633593Z","end":"2026-05-16T01:21:59.78906Z","steps":["trace[1187179674] 'agreement among raft nodes before linearized reading' (duration: 155.276888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:25:41.645597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.291943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-16T01:25:41.645903Z","caller":"traceutil/trace.go:171","msg":"trace[36972576] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"192.970664ms","start":"2026-05-16T01:25:41.452906Z","end":"2026-05-16T01:25:41.645877Z","steps":["trace[36972576] 'process raft request' (duration: 65.315024ms)","trace[36972576] 'compare' (duration: 127.139859ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:25:41.6465Z","caller":"traceutil/trace.go:171","msg":"trace[1181902622] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"193.519916ms","start":"2026-05-16T01:25:41.452967Z","end":"2026-05-16T01:25:41.646487Z","steps":["trace[1181902622] 'process raft request' (duration: 192.748069ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:25:41.647432Z","caller":"traceutil/trace.go:171","msg":"trace[519259034] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"194.326194ms","start":"2026-05-16T01:25:41.453088Z","end":"2026-05-16T01:25:41.647414Z","steps":["trace[519259034] 'process raft request' (duration: 192.743569ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:25:41.647588Z","caller":"traceutil/trace.go:171","msg":"trace[394941827] linearizableReadLoop","detail":"{readStateIndex:4887; appliedIndex:4883; }","duration":"178.472934ms","start":"2026-05-16T01:25:41.469104Z","end":"2026-05-16T01:25:41.647577Z","steps":["trace[394941827] 'read index received' (duration: 49.290019ms)","trace[394941827] 'applied index is now lower than readState.Index' (duration: 129.181885ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:25:41.647686Z","caller":"traceutil/trace.go:171","msg":"trace[1122580405] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"194.201561ms","start":"2026-05-16T01:25:41.453475Z","end":"2026-05-16T01:25:41.647677Z","steps":["trace[1122580405] 'process raft request' (duration: 193.888294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:25:41.647847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.739479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a329077d-ef16-4c0d-9aea-7f226efce283\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-16T01:25:41.64788Z","caller":"traceutil/trace.go:171","msg":"trace[1282445509] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a329077d-ef16-4c0d-9aea-7f226efce283; range_end:; response_count:1; response_revision:4707; }","duration":"178.797261ms","start":"2026-05-16T01:25:41.469074Z","end":"2026-05-16T01:25:41.647871Z","steps":["trace[1282445509] 'agreement among raft nodes before linearized reading' (duration: 178.682669ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:25:41.884018Z","caller":"traceutil/trace.go:171","msg":"trace[1729896711] linearizableReadLoop","detail":"{readStateIndex:4889; appliedIndex:4887; }","duration":"236.380543ms","start":"2026-05-16T01:25:41.647614Z","end":"2026-05-16T01:25:41.883995Z","steps":["trace[1729896711] 'read index received' (duration: 208.223751ms)","trace[1729896711] 'applied index is now lower than readState.Index' (duration: 28.155872ms)"],"step_count":2} {"level":"warn","ts":"2026-05-16T01:25:41.884399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.819971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-16T01:25:41.884459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.598702ms","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-16T01:25:41.884503Z","caller":"traceutil/trace.go:171","msg":"trace[129534034] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:4709; }","duration":"402.964573ms","start":"2026-05-16T01:25:41.481519Z","end":"2026-05-16T01:25:41.884483Z","steps":["trace[129534034] 'agreement among raft nodes before linearized reading' (duration: 402.775979ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:25:41.884539Z","caller":"traceutil/trace.go:171","msg":"trace[957131931] 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:4709; }","duration":"405.692035ms","start":"2026-05-16T01:25:41.478802Z","end":"2026-05-16T01:25:41.884494Z","steps":["trace[957131931] 'agreement among raft nodes before linearized reading' (duration: 405.48795ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:25:41.88459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:25:41.478785Z","time spent":"405.793226ms","remote":"127.0.0.1:32810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-05-16T01:25:41.88488Z","caller":"traceutil/trace.go:171","msg":"trace[1101548694] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"268.642737ms","start":"2026-05-16T01:25:41.616213Z","end":"2026-05-16T01:25:41.884856Z","steps":["trace[1101548694] 'process raft request' (duration: 267.717375ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:25:41.884943Z","caller":"traceutil/trace.go:171","msg":"trace[362832394] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"408.342234ms","start":"2026-05-16T01:25:41.476583Z","end":"2026-05-16T01:25:41.884925Z","steps":["trace[362832394] 'process raft request' (duration: 379.252981ms)","trace[362832394] 'compare' (duration: 27.61325ms)"],"step_count":2} {"level":"warn","ts":"2026-05-16T01:25:41.885038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:25:41.476574Z","time spent":"408.400945ms","remote":"127.0.0.1:32832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11833,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-16T01:25:41.885429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:25:41.481508Z","time spent":"403.906926ms","remote":"127.0.0.1:52348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "} {"level":"info","ts":"2026-05-16T01:25:42.401342Z","caller":"traceutil/trace.go:171","msg":"trace[356366446] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"100.594098ms","start":"2026-05-16T01:25:42.300722Z","end":"2026-05-16T01:25:42.401316Z","steps":["trace[356366446] 'process raft request' (duration: 12.517595ms)","trace[356366446] 'compare' (duration: 87.9055ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:25:56.573572Z","caller":"traceutil/trace.go:171","msg":"trace[347806887] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"129.813028ms","start":"2026-05-16T01:25:56.443737Z","end":"2026-05-16T01:25:56.57355Z","steps":["trace[347806887] 'process raft request' (duration: 129.653334ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:25:56.584402Z","caller":"traceutil/trace.go:171","msg":"trace[928006180] linearizableReadLoop","detail":"{readStateIndex:5072; appliedIndex:5069; }","duration":"123.049514ms","start":"2026-05-16T01:25:56.461327Z","end":"2026-05-16T01:25:56.584376Z","steps":["trace[928006180] 'read index received' (duration: 112.028168ms)","trace[928006180] 'applied index is now lower than readState.Index' (duration: 11.020116ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:25:56.584432Z","caller":"traceutil/trace.go:171","msg":"trace[1852771673] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"138.507675ms","start":"2026-05-16T01:25:56.445902Z","end":"2026-05-16T01:25:56.58441Z","steps":["trace[1852771673] 'process raft request' (duration: 138.293021ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:25:56.584501Z","caller":"traceutil/trace.go:171","msg":"trace[111869485] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"137.993394ms","start":"2026-05-16T01:25:56.446479Z","end":"2026-05-16T01:25:56.584472Z","steps":["trace[111869485] 'process raft request' (duration: 137.846911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:25:56.584682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.35108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-16T01:25:56.584743Z","caller":"traceutil/trace.go:171","msg":"trace[1492805186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4886; }","duration":"123.475973ms","start":"2026-05-16T01:25:56.461254Z","end":"2026-05-16T01:25:56.58473Z","steps":["trace[1492805186] 'agreement among raft nodes before linearized reading' (duration: 123.3076ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:25:56.709398Z","caller":"traceutil/trace.go:171","msg":"trace[54069131] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"120.395737ms","start":"2026-05-16T01:25:56.588982Z","end":"2026-05-16T01:25:56.709377Z","steps":["trace[54069131] 'process raft request' (duration: 72.168665ms)","trace[54069131] 'compare' (duration: 48.088289ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:25:56.709749Z","caller":"traceutil/trace.go:171","msg":"trace[1637447637] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"120.261804ms","start":"2026-05-16T01:25:56.58947Z","end":"2026-05-16T01:25:56.709732Z","steps":["trace[1637447637] 'process raft request' (duration: 119.872285ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:25:56.709857Z","caller":"traceutil/trace.go:171","msg":"trace[298156620] linearizableReadLoop","detail":"{readStateIndex:5075; appliedIndex:5072; }","duration":"117.733709ms","start":"2026-05-16T01:25:56.592102Z","end":"2026-05-16T01:25:56.709836Z","steps":["trace[298156620] 'read index received' (duration: 6.197882ms)","trace[298156620] 'applied index is now lower than readState.Index' (duration: 111.534597ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:25:56.710009Z","caller":"traceutil/trace.go:171","msg":"trace[45999537] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"115.134314ms","start":"2026-05-16T01:25:56.594862Z","end":"2026-05-16T01:25:56.709996Z","steps":["trace[45999537] 'process raft request' (duration: 114.745445ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:25:56.71025Z","caller":"traceutil/trace.go:171","msg":"trace[1670722095] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"113.139652ms","start":"2026-05-16T01:25:56.59688Z","end":"2026-05-16T01:25:56.710019Z","steps":["trace[1670722095] 'process raft request' (duration: 112.904437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:25:56.710756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.632809ms","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":"info","ts":"2026-05-16T01:25:56.710818Z","caller":"traceutil/trace.go:171","msg":"trace[2126713562] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4891; }","duration":"118.73422ms","start":"2026-05-16T01:25:56.592067Z","end":"2026-05-16T01:25:56.710801Z","steps":["trace[2126713562] 'agreement among raft nodes before linearized reading' (duration: 118.290251ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:27:31.229815Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2892} {"level":"info","ts":"2026-05-16T01:27:31.309632Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2892,"took":"78.44418ms","hash":3814328168,"current-db-size-bytes":53710848,"current-db-size":"54 MB","current-db-size-in-use-bytes":29609984,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-16T01:27:31.30972Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3814328168,"revision":2892,"compact-revision":-1} {"level":"info","ts":"2026-05-16T01:29:43.570346Z","caller":"traceutil/trace.go:171","msg":"trace[90688482] transaction","detail":"{read_only:false; response_revision:6520; number_of_response:1; }","duration":"147.84122ms","start":"2026-05-16T01:29:43.422476Z","end":"2026-05-16T01:29:43.570317Z","steps":["trace[90688482] 'process raft request' (duration: 147.771009ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:29:43.57063Z","caller":"traceutil/trace.go:171","msg":"trace[704568676] transaction","detail":"{read_only:false; response_revision:6519; number_of_response:1; }","duration":"148.614523ms","start":"2026-05-16T01:29:43.421971Z","end":"2026-05-16T01:29:43.570585Z","steps":["trace[704568676] 'process raft request' (duration: 106.303643ms)","trace[704568676] 'compare' (duration: 41.859362ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:32:31.23684Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5653} {"level":"info","ts":"2026-05-16T01:32:31.328975Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5653,"took":"90.845734ms","hash":865399477,"current-db-size-bytes":53710848,"current-db-size":"54 MB","current-db-size-in-use-bytes":18182144,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-16T01:32:31.329025Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":865399477,"revision":5653,"compact-revision":2892}