{"level":"warn","ts":"2026-05-19T13:12:56.057811Z","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-19T13:12:56.057935Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242: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-19T13:12:56.058259Z","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-19T13:12:56.058279Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-05-19T13:12:56.058307Z","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-19T13:12:56.059193Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-05-19T13:12:56.059286Z","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.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242: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-19T13:12:56.065055Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.538225ms"} {"level":"info","ts":"2026-05-19T13:12:56.073948Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-05-19T13:12:56.074081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T13:12:56.074126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-05-19T13:12:56.074141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T13:12:56.074162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-05-19T13:12:56.074219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-05-19T13:12:56.079454Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T13:12:56.080533Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T13:12:56.081474Z","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-19T13:12:56.084117Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T13:12:56.085362Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T13:12:56.085728Z","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-19T13:12:56.085803Z","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-19T13:12:56.085814Z","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-19T13:12:56.086514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-05-19T13:12:56.086644Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-05-19T13:12:56.093814Z","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-19T13:12:56.094058Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T13:12:56.09409Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T13:12:56.094626Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-05-19T13:12:56.094684Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-05-19T13:12:56.578675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T13:12:56.578762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T13:12:56.578783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-05-19T13:12:56.578799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-05-19T13:12:56.578805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-05-19T13:12:56.578814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-05-19T13:12:56.578823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-05-19T13:12:56.596527Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T13:12:56.596703Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T13:12:56.596811Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T13:12:56.596841Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T13:12:56.596744Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:12:56.597085Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T13:12:56.59859Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:12:56.598775Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:12:56.598854Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:12:56.600376Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T13:12:56.631674Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-05-19T13:12:58.275796Z","caller":"traceutil/trace.go:171","msg":"trace[1590175599] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"245.253246ms","start":"2026-05-19T13:12:58.030511Z","end":"2026-05-19T13:12:58.275764Z","steps":["trace[1590175599] 'read index received' (duration: 47.781774ms)","trace[1590175599] 'applied index is now lower than readState.Index' (duration: 197.470132ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:12:58.276141Z","caller":"traceutil/trace.go:171","msg":"trace[1798591922] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"245.836812ms","start":"2026-05-19T13:12:58.030289Z","end":"2026-05-19T13:12:58.276125Z","steps":["trace[1798591922] 'process raft request' (duration: 182.60207ms)","trace[1798591922] 'compare' (duration: 62.601275ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:12:58.276241Z","caller":"traceutil/trace.go:171","msg":"trace[1061232783] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"245.736019ms","start":"2026-05-19T13:12:58.030491Z","end":"2026-05-19T13:12:58.276227Z","steps":["trace[1061232783] 'process raft request' (duration: 245.218325ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:12:58.276401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.851763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:12:58.276524Z","caller":"traceutil/trace.go:171","msg":"trace[2034470885] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:4; }","duration":"246.013147ms","start":"2026-05-19T13:12:58.030487Z","end":"2026-05-19T13:12:58.2765Z","steps":["trace[2034470885] 'agreement among raft nodes before linearized reading' (duration: 245.698249ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:12:58.288311Z","caller":"traceutil/trace.go:171","msg":"trace[1908215311] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"182.578129ms","start":"2026-05-19T13:12:58.105701Z","end":"2026-05-19T13:12:58.288279Z","steps":["trace[1908215311] 'process raft request' (duration: 182.456565ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:12:58.288375Z","caller":"traceutil/trace.go:171","msg":"trace[476672076] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"182.562568ms","start":"2026-05-19T13:12:58.105781Z","end":"2026-05-19T13:12:58.288343Z","steps":["trace[476672076] 'process raft request' (duration: 182.488116ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:12:58.288365Z","caller":"traceutil/trace.go:171","msg":"trace[498218660] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"182.588649ms","start":"2026-05-19T13:12:58.105734Z","end":"2026-05-19T13:12:58.288323Z","steps":["trace[498218660] 'process raft request' (duration: 182.502857ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:12:58.288389Z","caller":"traceutil/trace.go:171","msg":"trace[1212605906] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"182.522867ms","start":"2026-05-19T13:12:58.105844Z","end":"2026-05-19T13:12:58.288367Z","steps":["trace[1212605906] 'process raft request' (duration: 182.455015ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:12:58.288475Z","caller":"traceutil/trace.go:171","msg":"trace[2132232815] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"182.25905ms","start":"2026-05-19T13:12:58.106206Z","end":"2026-05-19T13:12:58.288465Z","steps":["trace[2132232815] 'process raft request' (duration: 182.116166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:12:58.288556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.225739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:12:58.288586Z","caller":"traceutil/trace.go:171","msg":"trace[1931399374] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"182.281041ms","start":"2026-05-19T13:12:58.106296Z","end":"2026-05-19T13:12:58.288577Z","steps":["trace[1931399374] 'agreement among raft nodes before linearized reading' (duration: 182.201929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:12:58.288588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.525604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:12:58.288617Z","caller":"traceutil/trace.go:171","msg":"trace[1443299571] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:0; response_revision:11; }","duration":"184.607936ms","start":"2026-05-19T13:12:58.104001Z","end":"2026-05-19T13:12:58.288609Z","steps":["trace[1443299571] 'agreement among raft nodes before linearized reading' (duration: 184.511463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:12:58.288621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.237805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:12:58.288664Z","caller":"traceutil/trace.go:171","msg":"trace[454074655] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"182.25881ms","start":"2026-05-19T13:12:58.106399Z","end":"2026-05-19T13:12:58.288658Z","steps":["trace[454074655] 'process raft request' (duration: 181.968502ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:12:58.288687Z","caller":"traceutil/trace.go:171","msg":"trace[1385917212] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"210.311657ms","start":"2026-05-19T13:12:58.078343Z","end":"2026-05-19T13:12:58.288655Z","steps":["trace[1385917212] 'agreement among raft nodes before linearized reading' (duration: 210.219404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:12:58.288735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.810565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:12:58.288755Z","caller":"traceutil/trace.go:171","msg":"trace[444230013] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"182.831116ms","start":"2026-05-19T13:12:58.105918Z","end":"2026-05-19T13:12:58.288749Z","steps":["trace[444230013] 'agreement among raft nodes before linearized reading' (duration: 182.799195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:12:58.288833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.733999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:12:58.288865Z","caller":"traceutil/trace.go:171","msg":"trace[1649948712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"254.77888ms","start":"2026-05-19T13:12:58.034077Z","end":"2026-05-19T13:12:58.288856Z","steps":["trace[1649948712] 'agreement among raft nodes before linearized reading' (duration: 254.731768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:12:58.288979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.697418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:12:58.289319Z","caller":"traceutil/trace.go:171","msg":"trace[673636307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"254.923734ms","start":"2026-05-19T13:12:58.034266Z","end":"2026-05-19T13:12:58.28919Z","steps":["trace[673636307] 'agreement among raft nodes before linearized reading' (duration: 254.697097ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:12:58.288996Z","caller":"traceutil/trace.go:171","msg":"trace[1438601660] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"176.047477ms","start":"2026-05-19T13:12:58.112943Z","end":"2026-05-19T13:12:58.28899Z","steps":["trace[1438601660] 'process raft request' (duration: 175.504852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:12:58.289044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.590277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:12:58.289814Z","caller":"traceutil/trace.go:171","msg":"trace[1074450473] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"132.378699ms","start":"2026-05-19T13:12:58.157421Z","end":"2026-05-19T13:12:58.2898Z","steps":["trace[1074450473] 'agreement among raft nodes before linearized reading' (duration: 131.610557ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:13:31.169911Z","caller":"traceutil/trace.go:171","msg":"trace[1600001410] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"183.964014ms","start":"2026-05-19T13:13:30.985921Z","end":"2026-05-19T13:13:31.169885Z","steps":["trace[1600001410] 'process raft request' (duration: 182.137312ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:13:32.559737Z","caller":"traceutil/trace.go:171","msg":"trace[2065440979] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"123.789014ms","start":"2026-05-19T13:13:32.435919Z","end":"2026-05-19T13:13:32.559708Z","steps":["trace[2065440979] 'process raft request' (duration: 123.256733ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:13:32.81312Z","caller":"traceutil/trace.go:171","msg":"trace[80964561] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"246.68691ms","start":"2026-05-19T13:13:32.566396Z","end":"2026-05-19T13:13:32.813083Z","steps":["trace[80964561] 'process raft request' (duration: 148.647691ms)","trace[80964561] 'compare' (duration: 97.822334ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:13:32.890666Z","caller":"traceutil/trace.go:171","msg":"trace[2097988712] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"317.527412ms","start":"2026-05-19T13:13:32.573063Z","end":"2026-05-19T13:13:32.89059Z","steps":["trace[2097988712] 'process raft request' (duration: 317.113922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:13:32.891466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:13:32.573048Z","time spent":"317.744616ms","remote":"127.0.0.1:37978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:13:32.892409Z","caller":"traceutil/trace.go:171","msg":"trace[1884289093] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:641; }","duration":"318.505653ms","start":"2026-05-19T13:13:32.57386Z","end":"2026-05-19T13:13:32.892366Z","steps":["trace[1884289093] 'read index received' (duration: 141.249894ms)","trace[1884289093] 'applied index is now lower than readState.Index' (duration: 177.254769ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:13:32.892618Z","caller":"traceutil/trace.go:171","msg":"trace[320169733] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"271.440943ms","start":"2026-05-19T13:13:32.621118Z","end":"2026-05-19T13:13:32.892559Z","steps":["trace[320169733] 'process raft request' (duration: 270.01479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:13:32.892738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.838901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-19T13:13:32.892784Z","caller":"traceutil/trace.go:171","msg":"trace[1073036534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:624; }","duration":"318.936793ms","start":"2026-05-19T13:13:32.573833Z","end":"2026-05-19T13:13:32.89277Z","steps":["trace[1073036534] 'agreement among raft nodes before linearized reading' (duration: 318.732249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:13:32.892837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:13:32.573827Z","time spent":"318.997995ms","remote":"127.0.0.1:37978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T13:13:32.89287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.780499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:13:32.892973Z","caller":"traceutil/trace.go:171","msg":"trace[311920641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"292.911912ms","start":"2026-05-19T13:13:32.60004Z","end":"2026-05-19T13:13:32.892952Z","steps":["trace[311920641] 'agreement among raft nodes before linearized reading' (duration: 292.78194ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:13:33.379343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.380978ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T13:13:33.379516Z","caller":"traceutil/trace.go:171","msg":"trace[444364431] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"481.946441ms","start":"2026-05-19T13:13:32.897541Z","end":"2026-05-19T13:13:33.379487Z","steps":["trace[444364431] 'process raft request' (duration: 25.091371ms)","trace[444364431] 'compare' (duration: 456.201735ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:13:33.379601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:13:32.897522Z","time spent":"482.036092ms","remote":"127.0.0.1:37978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:13:33.655507Z","caller":"traceutil/trace.go:171","msg":"trace[518244059] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"697.825279ms","start":"2026-05-19T13:13:32.957644Z","end":"2026-05-19T13:13:33.655469Z","steps":["trace[518244059] 'process raft request' (duration: 671.035273ms)","trace[518244059] 'compare' (duration: 26.633762ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:13:33.655672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:13:32.957615Z","time spent":"697.979381ms","remote":"127.0.0.1:38204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T13:15:06.422738Z","caller":"traceutil/trace.go:171","msg":"trace[1743163999] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1932; }","duration":"300.839797ms","start":"2026-05-19T13:15:06.121875Z","end":"2026-05-19T13:15:06.422715Z","steps":["trace[1743163999] 'read index received' (duration: 300.635233ms)","trace[1743163999] 'applied index is now lower than readState.Index' (duration: 203.804µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:15:06.422827Z","caller":"traceutil/trace.go:171","msg":"trace[1061041582] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"337.499931ms","start":"2026-05-19T13:15:06.085274Z","end":"2026-05-19T13:15:06.422774Z","steps":["trace[1061041582] 'process raft request' (duration: 337.321098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:15:06.422992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.497065ms","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-19T13:15:06.42304Z","caller":"traceutil/trace.go:171","msg":"trace[1262947291] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1865; }","duration":"174.612637ms","start":"2026-05-19T13:15:06.248414Z","end":"2026-05-19T13:15:06.423027Z","steps":["trace[1262947291] 'agreement among raft nodes before linearized reading' (duration: 174.438464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:15:06.423137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:15:06.085258Z","time spent":"337.689234ms","remote":"127.0.0.1:37794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":967,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T13:15:06.423339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.424496ms","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-19T13:15:06.423609Z","caller":"traceutil/trace.go:171","msg":"trace[825499446] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1865; }","duration":"301.739151ms","start":"2026-05-19T13:15:06.121818Z","end":"2026-05-19T13:15:06.423557Z","steps":["trace[825499446] 'agreement among raft nodes before linearized reading' (duration: 301.03345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:15:06.423694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:15:06.121796Z","time spent":"301.884813ms","remote":"127.0.0.1:60546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-19T13:15:46.148497Z","caller":"traceutil/trace.go:171","msg":"trace[1049233194] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"172.043076ms","start":"2026-05-19T13:15:45.97642Z","end":"2026-05-19T13:15:46.148463Z","steps":["trace[1049233194] 'process raft request' (duration: 171.829613ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:15:46.996002Z","caller":"traceutil/trace.go:171","msg":"trace[1321516007] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"164.982846ms","start":"2026-05-19T13:15:46.830955Z","end":"2026-05-19T13:15:46.995938Z","steps":["trace[1321516007] 'process raft request' (duration: 122.064612ms)","trace[1321516007] 'compare' (duration: 42.165661ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:15:47.189706Z","caller":"traceutil/trace.go:171","msg":"trace[1270020569] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"208.410784ms","start":"2026-05-19T13:15:46.981251Z","end":"2026-05-19T13:15:47.189662Z","steps":["trace[1270020569] 'process raft request' (duration: 205.64583ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:16:36.006047Z","caller":"traceutil/trace.go:171","msg":"trace[1616586829] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"129.920822ms","start":"2026-05-19T13:16:35.876098Z","end":"2026-05-19T13:16:36.006019Z","steps":["trace[1616586829] 'process raft request' (duration: 129.75258ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:16:36.006122Z","caller":"traceutil/trace.go:171","msg":"trace[388269563] linearizableReadLoop","detail":"{readStateIndex:2595; appliedIndex:2595; }","duration":"125.707338ms","start":"2026-05-19T13:16:35.880394Z","end":"2026-05-19T13:16:36.006101Z","steps":["trace[388269563] 'read index received' (duration: 125.696778ms)","trace[388269563] 'applied index is now lower than readState.Index' (duration: 8.42µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:16:36.00633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.907261ms","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-19T13:16:36.006386Z","caller":"traceutil/trace.go:171","msg":"trace[790584087] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2507; }","duration":"125.994962ms","start":"2026-05-19T13:16:35.880374Z","end":"2026-05-19T13:16:36.006369Z","steps":["trace[790584087] 'agreement among raft nodes before linearized reading' (duration: 125.80992ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:17:08.746089Z","caller":"traceutil/trace.go:171","msg":"trace[292203993] transaction","detail":"{read_only:false; response_revision:2690; number_of_response:1; }","duration":"115.730394ms","start":"2026-05-19T13:17:08.630321Z","end":"2026-05-19T13:17:08.746051Z","steps":["trace[292203993] 'process raft request' (duration: 115.430358ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:17:08.910313Z","caller":"traceutil/trace.go:171","msg":"trace[1923449950] transaction","detail":"{read_only:false; response_revision:2691; number_of_response:1; }","duration":"158.89936ms","start":"2026-05-19T13:17:08.751381Z","end":"2026-05-19T13:17:08.91028Z","steps":["trace[1923449950] 'process raft request' (duration: 149.197369ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:07.010949Z","caller":"traceutil/trace.go:171","msg":"trace[112224497] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"123.971447ms","start":"2026-05-19T13:21:06.886959Z","end":"2026-05-19T13:21:07.010931Z","steps":["trace[112224497] 'process raft request' (duration: 123.829224ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:07.011343Z","caller":"traceutil/trace.go:171","msg":"trace[376095689] linearizableReadLoop","detail":"{readStateIndex:4837; appliedIndex:4834; }","duration":"124.131839ms","start":"2026-05-19T13:21:06.887193Z","end":"2026-05-19T13:21:07.011325Z","steps":["trace[376095689] 'read index received' (duration: 11.755657ms)","trace[376095689] 'applied index is now lower than readState.Index' (duration: 112.374932ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:21:07.011489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.282961ms","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":"info","ts":"2026-05-19T13:21:07.011339Z","caller":"traceutil/trace.go:171","msg":"trace[2138108867] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"124.274922ms","start":"2026-05-19T13:21:06.887032Z","end":"2026-05-19T13:21:07.011307Z","steps":["trace[2138108867] 'process raft request' (duration: 123.867295ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:07.01149Z","caller":"traceutil/trace.go:171","msg":"trace[522855221] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"124.17813ms","start":"2026-05-19T13:21:06.887255Z","end":"2026-05-19T13:21:07.011433Z","steps":["trace[522855221] 'process raft request' (duration: 123.917466ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:07.011514Z","caller":"traceutil/trace.go:171","msg":"trace[868276486] 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:4664; }","duration":"124.334083ms","start":"2026-05-19T13:21:06.88717Z","end":"2026-05-19T13:21:07.011504Z","steps":["trace[868276486] 'agreement among raft nodes before linearized reading' (duration: 124.219321ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:12.116134Z","caller":"traceutil/trace.go:171","msg":"trace[358608721] linearizableReadLoop","detail":"{readStateIndex:4946; appliedIndex:4945; }","duration":"131.264463ms","start":"2026-05-19T13:21:11.984854Z","end":"2026-05-19T13:21:12.116119Z","steps":["trace[358608721] 'read index received' (duration: 131.191531ms)","trace[358608721] 'applied index is now lower than readState.Index' (duration: 72.422µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:21:12.116246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.382545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-655fbed5-0b8d-4937-a014-b0a01c728a70\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-05-19T13:21:12.116269Z","caller":"traceutil/trace.go:171","msg":"trace[430599123] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-655fbed5-0b8d-4937-a014-b0a01c728a70; range_end:; response_count:1; response_revision:4771; }","duration":"131.455007ms","start":"2026-05-19T13:21:11.984807Z","end":"2026-05-19T13:21:12.116262Z","steps":["trace[430599123] 'agreement among raft nodes before linearized reading' (duration: 131.379515ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:12.116413Z","caller":"traceutil/trace.go:171","msg":"trace[1720988804] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"294.805841ms","start":"2026-05-19T13:21:11.821574Z","end":"2026-05-19T13:21:12.116379Z","steps":["trace[1720988804] 'process raft request' (duration: 294.393073ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:55.417094Z","caller":"traceutil/trace.go:171","msg":"trace[1535707904] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"117.0154ms","start":"2026-05-19T13:21:55.300054Z","end":"2026-05-19T13:21:55.417069Z","steps":["trace[1535707904] 'process raft request' (duration: 116.860767ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:22:37.143557Z","caller":"traceutil/trace.go:171","msg":"trace[1350565890] transaction","detail":"{read_only:false; response_revision:5508; number_of_response:1; }","duration":"144.710546ms","start":"2026-05-19T13:22:36.998809Z","end":"2026-05-19T13:22:37.143519Z","steps":["trace[1350565890] 'process raft request' (duration: 55.028796ms)","trace[1350565890] 'compare' (duration: 89.522777ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:22:37.366253Z","caller":"traceutil/trace.go:171","msg":"trace[261390731] transaction","detail":"{read_only:false; response_revision:5509; number_of_response:1; }","duration":"218.121449ms","start":"2026-05-19T13:22:37.148113Z","end":"2026-05-19T13:22:37.366234Z","steps":["trace[261390731] 'process raft request' (duration: 149.667926ms)","trace[261390731] 'compare' (duration: 68.280611ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:22:56.782695Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2944} {"level":"info","ts":"2026-05-19T13:22:56.869651Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2944,"took":"85.442993ms","hash":4157422665,"current-db-size-bytes":53911552,"current-db-size":"54 MB","current-db-size-in-use-bytes":29499392,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-19T13:22:56.869835Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4157422665,"revision":2944,"compact-revision":-1} {"level":"info","ts":"2026-05-19T13:27:56.788883Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5659} {"level":"info","ts":"2026-05-19T13:27:56.891261Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5659,"took":"100.723713ms","hash":3859583102,"current-db-size-bytes":53911552,"current-db-size":"54 MB","current-db-size-in-use-bytes":18382848,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-19T13:27:56.891319Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3859583102,"revision":5659,"compact-revision":2944}