{"level":"warn","ts":"2026-05-05T11:16:00.856534Z","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-05T11:16:00.856688Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.185:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.185:2380","--initial-cluster=instance=https://199.19.213.185:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.185:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.185: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-05T11:16:00.856972Z","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-05T11:16:00.85699Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.185:2380"]} {"level":"info","ts":"2026-05-05T11:16:00.857251Z","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-05T11:16:00.858112Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.185:2379"]} {"level":"info","ts":"2026-05-05T11:16:00.858308Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.185:2380"],"listen-peer-urls":["https://199.19.213.185:2380"],"advertise-client-urls":["https://199.19.213.185:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.185:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.185: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-05T11:16:00.862151Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.523174ms"} {"level":"info","ts":"2026-05-05T11:16:00.871765Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dcbda34f8b503a3","cluster-id":"2e806bc52dde46af"} {"level":"info","ts":"2026-05-05T11:16:00.871837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T11:16:00.871884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became follower at term 0"} {"level":"info","ts":"2026-05-05T11:16:00.871895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dcbda34f8b503a3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T11:16:00.871906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became follower at term 1"} {"level":"info","ts":"2026-05-05T11:16:00.871973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 switched to configuration voters=(994128063811093411)"} {"level":"warn","ts":"2026-05-05T11:16:00.879857Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T11:16:00.884401Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T11:16:00.885668Z","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-05T11:16:00.888679Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dcbda34f8b503a3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T11:16:00.889054Z","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-05T11:16:00.889704Z","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-05T11:16:00.889784Z","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-05T11:16:00.889614Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dcbda34f8b503a3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T11:16:00.890231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 switched to configuration voters=(994128063811093411)"} {"level":"info","ts":"2026-05-05T11:16:00.890549Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2e806bc52dde46af","local-member-id":"dcbda34f8b503a3","added-peer-id":"dcbda34f8b503a3","added-peer-peer-urls":["https://199.19.213.185:2380"]} {"level":"info","ts":"2026-05-05T11:16:00.893585Z","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-05T11:16:00.893643Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.185:2380"} {"level":"info","ts":"2026-05-05T11:16:00.893735Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.185:2380"} {"level":"info","ts":"2026-05-05T11:16:00.893996Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dcbda34f8b503a3","initial-advertise-peer-urls":["https://199.19.213.185:2380"],"listen-peer-urls":["https://199.19.213.185:2380"],"advertise-client-urls":["https://199.19.213.185:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.185:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T11:16:00.894038Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T11:16:00.972696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T11:16:00.972782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T11:16:00.972853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 received MsgPreVoteResp from dcbda34f8b503a3 at term 1"} {"level":"info","ts":"2026-05-05T11:16:00.972884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became candidate at term 2"} {"level":"info","ts":"2026-05-05T11:16:00.972902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 received MsgVoteResp from dcbda34f8b503a3 at term 2"} {"level":"info","ts":"2026-05-05T11:16:00.972925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became leader at term 2"} {"level":"info","ts":"2026-05-05T11:16:00.972945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dcbda34f8b503a3 elected leader dcbda34f8b503a3 at term 2"} {"level":"info","ts":"2026-05-05T11:16:00.974073Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dcbda34f8b503a3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.185:2379]}","request-path":"/0/members/dcbda34f8b503a3/attributes","cluster-id":"2e806bc52dde46af","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T11:16:00.974262Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T11:16:00.974308Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T11:16:00.974626Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:16:00.975696Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2e806bc52dde46af","local-member-id":"dcbda34f8b503a3","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:16:00.97601Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:16:00.97607Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:16:00.977757Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.185:2379"} {"level":"info","ts":"2026-05-05T11:16:00.97789Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T11:16:00.977917Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T11:16:00.980894Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T11:16:05.245036Z","caller":"traceutil/trace.go:171","msg":"trace[543255621] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"264.947993ms","start":"2026-05-05T11:16:04.980063Z","end":"2026-05-05T11:16:05.245011Z","steps":["trace[543255621] 'process raft request' (duration: 264.814136ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:16:05.400227Z","caller":"traceutil/trace.go:171","msg":"trace[339357710] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"135.687315ms","start":"2026-05-05T11:16:05.264512Z","end":"2026-05-05T11:16:05.4002Z","steps":["trace[339357710] 'process raft request' (duration: 132.172619ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:17:24.602905Z","caller":"traceutil/trace.go:171","msg":"trace[348759725] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"110.253895ms","start":"2026-05-05T11:17:24.492634Z","end":"2026-05-05T11:17:24.602888Z","steps":["trace[348759725] 'process raft request' (duration: 100.006267ms)","trace[348759725] 'compare' (duration: 10.156584ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:17:24.603701Z","caller":"traceutil/trace.go:171","msg":"trace[1494572505] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"106.283453ms","start":"2026-05-05T11:17:24.497401Z","end":"2026-05-05T11:17:24.603685Z","steps":["trace[1494572505] 'process raft request' (duration: 106.039879ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:17:24.603867Z","caller":"traceutil/trace.go:171","msg":"trace[535956489] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"101.527011ms","start":"2026-05-05T11:17:24.502333Z","end":"2026-05-05T11:17:24.60386Z","steps":["trace[535956489] 'process raft request' (duration: 101.200972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:17:30.463178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.229363ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:17:30.463466Z","caller":"traceutil/trace.go:171","msg":"trace[1178400730] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"132.437129ms","start":"2026-05-05T11:17:30.330919Z","end":"2026-05-05T11:17:30.463356Z","steps":["trace[1178400730] 'process raft request' (duration: 15.708022ms)","trace[1178400730] 'compare' (duration: 116.078701ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:17:30.921744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.600858ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:17:30.921958Z","caller":"traceutil/trace.go:171","msg":"trace[789095098] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"351.74243ms","start":"2026-05-05T11:17:30.57009Z","end":"2026-05-05T11:17:30.921832Z","steps":["trace[789095098] 'process raft request' (duration: 187.40671ms)","trace[789095098] 'compare' (duration: 163.380619ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:17:30.922042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:17:30.570067Z","time spent":"351.938662ms","remote":"127.0.0.1:54972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T11:17:31.305914Z","caller":"traceutil/trace.go:171","msg":"trace[882646245] linearizableReadLoop","detail":"{readStateIndex:742; appliedIndex:741; }","duration":"164.431214ms","start":"2026-05-05T11:17:31.141426Z","end":"2026-05-05T11:17:31.305858Z","steps":["trace[882646245] 'read index received' (duration: 131.280554ms)","trace[882646245] 'applied index is now lower than readState.Index' (duration: 33.14955ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:17:31.306036Z","caller":"traceutil/trace.go:171","msg":"trace[1510086951] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"272.119952ms","start":"2026-05-05T11:17:31.033875Z","end":"2026-05-05T11:17:31.305995Z","steps":["trace[1510086951] 'process raft request' (duration: 238.899996ms)","trace[1510086951] 'compare' (duration: 32.920321ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:17:31.306135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.930915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-05T11:17:31.306173Z","caller":"traceutil/trace.go:171","msg":"trace[1234096442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:706; }","duration":"134.03192ms","start":"2026-05-05T11:17:31.17213Z","end":"2026-05-05T11:17:31.306162Z","steps":["trace[1234096442] 'agreement among raft nodes before linearized reading' (duration: 133.904786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:17:31.30623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.786417ms","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-05T11:17:31.306313Z","caller":"traceutil/trace.go:171","msg":"trace[848207726] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:706; }","duration":"164.907891ms","start":"2026-05-05T11:17:31.141384Z","end":"2026-05-05T11:17:31.306292Z","steps":["trace[848207726] 'agreement among raft nodes before linearized reading' (duration: 164.636744ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:17:31.485523Z","caller":"traceutil/trace.go:171","msg":"trace[815480899] linearizableReadLoop","detail":"{readStateIndex:745; appliedIndex:742; }","duration":"172.768387ms","start":"2026-05-05T11:17:31.312724Z","end":"2026-05-05T11:17:31.485493Z","steps":["trace[815480899] 'read index received' (duration: 92.181315ms)","trace[815480899] 'applied index is now lower than readState.Index' (duration: 80.585922ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:17:31.485592Z","caller":"traceutil/trace.go:171","msg":"trace[259396960] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"174.874164ms","start":"2026-05-05T11:17:31.310681Z","end":"2026-05-05T11:17:31.485555Z","steps":["trace[259396960] 'process raft request' (duration: 174.516032ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:17:31.485641Z","caller":"traceutil/trace.go:171","msg":"trace[1950792928] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"174.652925ms","start":"2026-05-05T11:17:31.310966Z","end":"2026-05-05T11:17:31.485619Z","steps":["trace[1950792928] 'process raft request' (duration: 174.461614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:17:31.485742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.983407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-05T11:17:31.485865Z","caller":"traceutil/trace.go:171","msg":"trace[697249398] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:709; }","duration":"173.156898ms","start":"2026-05-05T11:17:31.31269Z","end":"2026-05-05T11:17:31.485847Z","steps":["trace[697249398] 'agreement among raft nodes before linearized reading' (duration: 172.971247ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:18:28.983749Z","caller":"traceutil/trace.go:171","msg":"trace[1368582813] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"105.513513ms","start":"2026-05-05T11:18:28.878207Z","end":"2026-05-05T11:18:28.983721Z","steps":["trace[1368582813] 'process raft request' (duration: 105.380171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:19:00.016258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.845164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2c3f000-f523-4517-8b05-9c6adf09c211\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-05T11:19:00.016341Z","caller":"traceutil/trace.go:171","msg":"trace[806873011] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c2c3f000-f523-4517-8b05-9c6adf09c211; range_end:; response_count:1; response_revision:1922; }","duration":"258.938188ms","start":"2026-05-05T11:18:59.757386Z","end":"2026-05-05T11:19:00.016324Z","steps":["trace[806873011] 'range keys from in-memory index tree' (duration: 258.672286ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:19:49.161707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.324573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-05T11:19:49.161917Z","caller":"traceutil/trace.go:171","msg":"trace[1072542887] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2240; }","duration":"195.596608ms","start":"2026-05-05T11:19:48.966288Z","end":"2026-05-05T11:19:49.161884Z","steps":["trace[1072542887] 'range keys from in-memory index tree' (duration: 195.036247ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:19:49.45024Z","caller":"traceutil/trace.go:171","msg":"trace[5915354] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"122.813878ms","start":"2026-05-05T11:19:49.3274Z","end":"2026-05-05T11:19:49.450214Z","steps":["trace[5915354] 'process raft request' (duration: 122.564184ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:50.746476Z","caller":"traceutil/trace.go:171","msg":"trace[1791097863] transaction","detail":"{read_only:false; response_revision:3000; number_of_response:1; }","duration":"105.723754ms","start":"2026-05-05T11:21:50.640727Z","end":"2026-05-05T11:21:50.746451Z","steps":["trace[1791097863] 'process raft request' (duration: 43.831645ms)","trace[1791097863] 'compare' (duration: 61.794163ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:21:52.9395Z","caller":"traceutil/trace.go:171","msg":"trace[1773080879] transaction","detail":"{read_only:false; response_revision:3012; number_of_response:1; }","duration":"106.399175ms","start":"2026-05-05T11:21:52.833071Z","end":"2026-05-05T11:21:52.93947Z","steps":["trace[1773080879] 'process raft request' (duration: 57.612254ms)","trace[1773080879] 'compare' (duration: 48.664623ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:21:53.591052Z","caller":"traceutil/trace.go:171","msg":"trace[1133119413] linearizableReadLoop","detail":"{readStateIndex:3136; appliedIndex:3135; }","duration":"139.716641ms","start":"2026-05-05T11:21:53.451309Z","end":"2026-05-05T11:21:53.591026Z","steps":["trace[1133119413] 'read index received' (duration: 41.446789ms)","trace[1133119413] 'applied index is now lower than readState.Index' (duration: 98.268782ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:21:53.591145Z","caller":"traceutil/trace.go:171","msg":"trace[1170115170] transaction","detail":"{read_only:false; response_revision:3017; number_of_response:1; }","duration":"160.203579ms","start":"2026-05-05T11:21:53.430896Z","end":"2026-05-05T11:21:53.591099Z","steps":["trace[1170115170] 'process raft request' (duration: 61.947908ms)","trace[1170115170] 'compare' (duration: 98.075489ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:21:53.591383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.051913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:21:53.591579Z","caller":"traceutil/trace.go:171","msg":"trace[885037210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3017; }","duration":"140.177642ms","start":"2026-05-05T11:21:53.451261Z","end":"2026-05-05T11:21:53.591438Z","steps":["trace[885037210] 'agreement among raft nodes before linearized reading' (duration: 139.902623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:24:48.524289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.331894ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:24:48.524451Z","caller":"traceutil/trace.go:171","msg":"trace[1155261626] transaction","detail":"{read_only:false; response_revision:4558; number_of_response:1; }","duration":"163.793244ms","start":"2026-05-05T11:24:48.360636Z","end":"2026-05-05T11:24:48.524429Z","steps":["trace[1155261626] 'process raft request' (duration: 39.231506ms)","trace[1155261626] 'compare' (duration: 124.04722ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:24:50.729615Z","caller":"traceutil/trace.go:171","msg":"trace[729949159] transaction","detail":"{read_only:false; response_revision:4610; number_of_response:1; }","duration":"108.743909ms","start":"2026-05-05T11:24:50.620849Z","end":"2026-05-05T11:24:50.729592Z","steps":["trace[729949159] 'process raft request' (duration: 108.640677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:24:56.049373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.969935ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:24:56.049637Z","caller":"traceutil/trace.go:171","msg":"trace[230916933] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"116.24394ms","start":"2026-05-05T11:24:55.933276Z","end":"2026-05-05T11:24:56.049519Z","steps":["trace[230916933] 'process raft request' (duration: 14.01871ms)","trace[230916933] 'compare' (duration: 101.835703ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:24:56.192169Z","caller":"traceutil/trace.go:171","msg":"trace[1195845466] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"132.251413ms","start":"2026-05-05T11:24:56.059896Z","end":"2026-05-05T11:24:56.192147Z","steps":["trace[1195845466] 'process raft request' (duration: 132.140861ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:24:56.193651Z","caller":"traceutil/trace.go:171","msg":"trace[2126629226] linearizableReadLoop","detail":"{readStateIndex:4929; appliedIndex:4927; }","duration":"109.684212ms","start":"2026-05-05T11:24:56.083943Z","end":"2026-05-05T11:24:56.193627Z","steps":["trace[2126629226] 'read index received' (duration: 108.173362ms)","trace[2126629226] 'applied index is now lower than readState.Index' (duration: 1.5094ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:24:56.193688Z","caller":"traceutil/trace.go:171","msg":"trace[1401734007] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"132.781283ms","start":"2026-05-05T11:24:56.060873Z","end":"2026-05-05T11:24:56.193655Z","steps":["trace[1401734007] 'process raft request' (duration: 132.309444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:24:56.193948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.986478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-05-05T11:24:56.194215Z","caller":"traceutil/trace.go:171","msg":"trace[446047429] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4744; }","duration":"110.288494ms","start":"2026-05-05T11:24:56.083898Z","end":"2026-05-05T11:24:56.194187Z","steps":["trace[446047429] 'agreement among raft nodes before linearized reading' (duration: 109.833595ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:24:56.842365Z","caller":"traceutil/trace.go:171","msg":"trace[929185611] linearizableReadLoop","detail":"{readStateIndex:4932; appliedIndex:4931; }","duration":"166.577973ms","start":"2026-05-05T11:24:56.675769Z","end":"2026-05-05T11:24:56.842347Z","steps":["trace[929185611] 'read index received' (duration: 166.494062ms)","trace[929185611] 'applied index is now lower than readState.Index' (duration: 83.081µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:24:56.842417Z","caller":"traceutil/trace.go:171","msg":"trace[1362091458] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"255.868849ms","start":"2026-05-05T11:24:56.58651Z","end":"2026-05-05T11:24:56.842379Z","steps":["trace[1362091458] 'process raft request' (duration: 255.711555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:24:56.842548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.767028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-f4cbb4cb7-ssd9l.18aca7a8a4b74c99\" ","response":"range_response_count:1 size:893"} {"level":"info","ts":"2026-05-05T11:24:56.842601Z","caller":"traceutil/trace.go:171","msg":"trace[859297253] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-f4cbb4cb7-ssd9l.18aca7a8a4b74c99; range_end:; response_count:1; response_revision:4747; }","duration":"166.8743ms","start":"2026-05-05T11:24:56.675703Z","end":"2026-05-05T11:24:56.842577Z","steps":["trace[859297253] 'agreement among raft nodes before linearized reading' (duration: 166.728277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:24:56.842581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.785168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-05-05T11:24:56.842647Z","caller":"traceutil/trace.go:171","msg":"trace[1238850153] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4747; }","duration":"166.894351ms","start":"2026-05-05T11:24:56.675735Z","end":"2026-05-05T11:24:56.84263Z","steps":["trace[1238850153] 'agreement among raft nodes before linearized reading' (duration: 166.656056ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:24:56.912899Z","caller":"traceutil/trace.go:171","msg":"trace[307759173] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"152.869126ms","start":"2026-05-05T11:24:56.760004Z","end":"2026-05-05T11:24:56.912873Z","steps":["trace[307759173] 'process raft request' (duration: 152.694393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:24:56.913086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.172572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"warn","ts":"2026-05-05T11:24:56.91314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.644896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-05T11:24:56.913226Z","caller":"traceutil/trace.go:171","msg":"trace[1171048662] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4748; }","duration":"162.79502ms","start":"2026-05-05T11:24:56.75041Z","end":"2026-05-05T11:24:56.913205Z","steps":["trace[1171048662] 'agreement among raft nodes before linearized reading' (duration: 162.515914ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:24:56.913231Z","caller":"traceutil/trace.go:171","msg":"trace[1100804422] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4748; }","duration":"153.317905ms","start":"2026-05-05T11:24:56.759851Z","end":"2026-05-05T11:24:56.913169Z","steps":["trace[1100804422] 'agreement among raft nodes before linearized reading' (duration: 153.04436ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:24:56.956401Z","caller":"traceutil/trace.go:171","msg":"trace[1961259262] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"111.438207ms","start":"2026-05-05T11:24:56.844941Z","end":"2026-05-05T11:24:56.956379Z","steps":["trace[1961259262] 'process raft request' (duration: 98.338541ms)","trace[1961259262] 'compare' (duration: 12.916342ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:24:56.95781Z","caller":"traceutil/trace.go:171","msg":"trace[1328355324] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"101.983353ms","start":"2026-05-05T11:24:56.8558Z","end":"2026-05-05T11:24:56.957784Z","steps":["trace[1328355324] 'process raft request' (duration: 100.526304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:24:56.957888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.877369ms","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-05T11:24:56.958041Z","caller":"traceutil/trace.go:171","msg":"trace[348792494] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:4750; }","duration":"105.076253ms","start":"2026-05-05T11:24:56.85295Z","end":"2026-05-05T11:24:56.958026Z","steps":["trace[348792494] 'agreement among raft nodes before linearized reading' (duration: 104.825449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:21.083351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.695589ms","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-05T11:25:21.083437Z","caller":"traceutil/trace.go:171","msg":"trace[1165520017] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4998; }","duration":"115.799101ms","start":"2026-05-05T11:25:20.967612Z","end":"2026-05-05T11:25:21.083411Z","steps":["trace[1165520017] 'range keys from in-memory index tree' (duration: 115.565135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:21.083358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.79165ms","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-05T11:25:21.083636Z","caller":"traceutil/trace.go:171","msg":"trace[1466625405] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4998; }","duration":"123.126998ms","start":"2026-05-05T11:25:20.960498Z","end":"2026-05-05T11:25:21.083625Z","steps":["trace[1466625405] 'range keys from in-memory index tree' (duration: 122.618725ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:21.310886Z","caller":"traceutil/trace.go:171","msg":"trace[429738054] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"223.120819ms","start":"2026-05-05T11:25:21.087697Z","end":"2026-05-05T11:25:21.310818Z","steps":["trace[429738054] 'process raft request' (duration: 222.946035ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:21.316059Z","caller":"traceutil/trace.go:171","msg":"trace[524186708] linearizableReadLoop","detail":"{readStateIndex:5195; appliedIndex:5193; }","duration":"110.891583ms","start":"2026-05-05T11:25:21.205141Z","end":"2026-05-05T11:25:21.316033Z","steps":["trace[524186708] 'read index received' (duration: 105.581856ms)","trace[524186708] 'applied index is now lower than readState.Index' (duration: 5.308497ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:25:21.316189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.031866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:25:21.316232Z","caller":"traceutil/trace.go:171","msg":"trace[1779602748] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:5001; }","duration":"111.134598ms","start":"2026-05-05T11:25:21.205083Z","end":"2026-05-05T11:25:21.316218Z","steps":["trace[1779602748] 'agreement among raft nodes before linearized reading' (duration: 111.050596ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:21.316111Z","caller":"traceutil/trace.go:171","msg":"trace[2125137069] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"227.919613ms","start":"2026-05-05T11:25:21.08816Z","end":"2026-05-05T11:25:21.31608Z","steps":["trace[2125137069] 'process raft request' (duration: 227.721308ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:26:01.353324Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2742} {"level":"info","ts":"2026-05-05T11:26:01.423985Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2742,"took":"69.432574ms","hash":468762384,"current-db-size-bytes":51728384,"current-db-size":"52 MB","current-db-size-in-use-bytes":28348416,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-05T11:26:01.424049Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":468762384,"revision":2742,"compact-revision":-1} {"level":"info","ts":"2026-05-05T11:29:19.327465Z","caller":"traceutil/trace.go:171","msg":"trace[1382201437] transaction","detail":"{read_only:false; response_revision:6726; number_of_response:1; }","duration":"142.559502ms","start":"2026-05-05T11:29:19.184879Z","end":"2026-05-05T11:29:19.327439Z","steps":["trace[1382201437] 'process raft request' (duration: 142.000743ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:31:01.359837Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5324} {"level":"info","ts":"2026-05-05T11:31:01.433874Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5324,"took":"72.385587ms","hash":3039980406,"current-db-size-bytes":51728384,"current-db-size":"52 MB","current-db-size-in-use-bytes":18546688,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-05T11:31:01.43395Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3039980406,"revision":5324,"compact-revision":2742}