{"level":"warn","ts":"2026-05-06T04:58:41.967145Z","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-06T04:58:41.967244Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.82: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.82:2380","--initial-cluster=instance=https://199.19.213.82:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.82:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.82: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-06T04:58:41.96732Z","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-06T04:58:41.967336Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.82:2380"]} {"level":"info","ts":"2026-05-06T04:58:41.967358Z","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-06T04:58:41.968435Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.82:2379"]} {"level":"info","ts":"2026-05-06T04:58:41.968534Z","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.82:2380"],"listen-peer-urls":["https://199.19.213.82:2380"],"advertise-client-urls":["https://199.19.213.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.82: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-06T04:58:41.976315Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.522088ms"} {"level":"info","ts":"2026-05-06T04:58:41.993026Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5d464d3ed167a141","cluster-id":"2ab4f6fe2538e5aa"} {"level":"info","ts":"2026-05-06T04:58:41.993147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T04:58:41.993187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 became follower at term 0"} {"level":"info","ts":"2026-05-06T04:58:41.99322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5d464d3ed167a141 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T04:58:41.993257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 became follower at term 1"} {"level":"info","ts":"2026-05-06T04:58:41.993315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 switched to configuration voters=(6721144426093584705)"} {"level":"warn","ts":"2026-05-06T04:58:42.001444Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T04:58:42.004404Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T04:58:42.006527Z","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-06T04:58:42.009663Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5d464d3ed167a141","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T04:58:42.009817Z","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-06T04:58:42.009912Z","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-06T04:58:42.00992Z","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-06T04:58:42.009988Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5d464d3ed167a141","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T04:58:42.011961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 switched to configuration voters=(6721144426093584705)"} {"level":"info","ts":"2026-05-06T04:58:42.012302Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2ab4f6fe2538e5aa","local-member-id":"5d464d3ed167a141","added-peer-id":"5d464d3ed167a141","added-peer-peer-urls":["https://199.19.213.82:2380"]} {"level":"info","ts":"2026-05-06T04:58:42.013313Z","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-06T04:58:42.01341Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.82:2380"} {"level":"info","ts":"2026-05-06T04:58:42.013475Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.82:2380"} {"level":"info","ts":"2026-05-06T04:58:42.013505Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5d464d3ed167a141","initial-advertise-peer-urls":["https://199.19.213.82:2380"],"listen-peer-urls":["https://199.19.213.82:2380"],"advertise-client-urls":["https://199.19.213.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T04:58:42.01353Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T04:58:42.593823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T04:58:42.593867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T04:58:42.593931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 received MsgPreVoteResp from 5d464d3ed167a141 at term 1"} {"level":"info","ts":"2026-05-06T04:58:42.593945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 became candidate at term 2"} {"level":"info","ts":"2026-05-06T04:58:42.593951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 received MsgVoteResp from 5d464d3ed167a141 at term 2"} {"level":"info","ts":"2026-05-06T04:58:42.59396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 became leader at term 2"} {"level":"info","ts":"2026-05-06T04:58:42.593968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5d464d3ed167a141 elected leader 5d464d3ed167a141 at term 2"} {"level":"info","ts":"2026-05-06T04:58:42.595499Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5d464d3ed167a141","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.82:2379]}","request-path":"/0/members/5d464d3ed167a141/attributes","cluster-id":"2ab4f6fe2538e5aa","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T04:58:42.595504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T04:58:42.595624Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:58:42.595967Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T04:58:42.596032Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T04:58:42.595736Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T04:58:42.597366Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2ab4f6fe2538e5aa","local-member-id":"5d464d3ed167a141","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:58:42.597535Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:58:42.597607Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:58:42.599007Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T04:58:42.603846Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.82:2379"} {"level":"info","ts":"2026-05-06T04:59:10.420506Z","caller":"traceutil/trace.go:171","msg":"trace[2028139002] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"103.854351ms","start":"2026-05-06T04:59:10.316619Z","end":"2026-05-06T04:59:10.420474Z","steps":["trace[2028139002] 'process raft request' (duration: 103.705078ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:10.424499Z","caller":"traceutil/trace.go:171","msg":"trace[544616979] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"105.82943ms","start":"2026-05-06T04:59:10.318655Z","end":"2026-05-06T04:59:10.424485Z","steps":["trace[544616979] 'process raft request' (duration: 105.752088ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:10.854028Z","caller":"traceutil/trace.go:171","msg":"trace[1364407334] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"100.901634ms","start":"2026-05-06T04:59:10.752845Z","end":"2026-05-06T04:59:10.853746Z","steps":["trace[1364407334] 'process raft request' (duration: 100.70982ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:10.872308Z","caller":"traceutil/trace.go:171","msg":"trace[1093261711] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"117.628457ms","start":"2026-05-06T04:59:10.754661Z","end":"2026-05-06T04:59:10.87229Z","steps":["trace[1093261711] 'process raft request' (duration: 116.435373ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:10.872423Z","caller":"traceutil/trace.go:171","msg":"trace[127660102] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"110.962158ms","start":"2026-05-06T04:59:10.761452Z","end":"2026-05-06T04:59:10.872414Z","steps":["trace[127660102] 'process raft request' (duration: 110.784195ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:10.872545Z","caller":"traceutil/trace.go:171","msg":"trace[1085838393] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"110.620512ms","start":"2026-05-06T04:59:10.761908Z","end":"2026-05-06T04:59:10.872529Z","steps":["trace[1085838393] 'process raft request' (duration: 110.369087ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:10.872644Z","caller":"traceutil/trace.go:171","msg":"trace[1251213790] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"108.419549ms","start":"2026-05-06T04:59:10.764216Z","end":"2026-05-06T04:59:10.872636Z","steps":["trace[1251213790] 'process raft request' (duration: 108.113243ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:10.873083Z","caller":"traceutil/trace.go:171","msg":"trace[2130969240] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"108.531802ms","start":"2026-05-06T04:59:10.764543Z","end":"2026-05-06T04:59:10.873075Z","steps":["trace[2130969240] 'process raft request' (duration: 108.388249ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:10.873287Z","caller":"traceutil/trace.go:171","msg":"trace[1175231193] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"104.457142ms","start":"2026-05-06T04:59:10.768812Z","end":"2026-05-06T04:59:10.873269Z","steps":["trace[1175231193] 'process raft request' (duration: 104.185107ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:10.873677Z","caller":"traceutil/trace.go:171","msg":"trace[359819142] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"103.441194ms","start":"2026-05-06T04:59:10.770219Z","end":"2026-05-06T04:59:10.87366Z","steps":["trace[359819142] 'process raft request' (duration: 102.814792ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:11.853601Z","caller":"traceutil/trace.go:171","msg":"trace[1374563211] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"246.487829ms","start":"2026-05-06T04:59:11.607068Z","end":"2026-05-06T04:59:11.853556Z","steps":["trace[1374563211] 'process raft request' (duration: 245.867097ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:16.78956Z","caller":"traceutil/trace.go:171","msg":"trace[647045300] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"148.311835ms","start":"2026-05-06T04:59:16.64121Z","end":"2026-05-06T04:59:16.789522Z","steps":["trace[647045300] 'read index received' (duration: 146.946822ms)","trace[647045300] 'applied index is now lower than readState.Index' (duration: 1.363593ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T04:59:16.789853Z","caller":"traceutil/trace.go:171","msg":"trace[1644282303] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"150.876879ms","start":"2026-05-06T04:59:16.638759Z","end":"2026-05-06T04:59:16.789636Z","steps":["trace[1644282303] 'process raft request' (duration: 149.829242ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:59:16.790124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.825084ms","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-06T04:59:16.790275Z","caller":"traceutil/trace.go:171","msg":"trace[1330944896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"149.071558ms","start":"2026-05-06T04:59:16.641186Z","end":"2026-05-06T04:59:16.790257Z","steps":["trace[1330944896] 'agreement among raft nodes before linearized reading' (duration: 148.510208ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:32.757984Z","caller":"traceutil/trace.go:171","msg":"trace[1529794892] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"156.070416ms","start":"2026-05-06T04:59:32.601895Z","end":"2026-05-06T04:59:32.757965Z","steps":["trace[1529794892] 'process raft request' (duration: 155.946574ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:32.760564Z","caller":"traceutil/trace.go:171","msg":"trace[1118555931] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"158.567969ms","start":"2026-05-06T04:59:32.601966Z","end":"2026-05-06T04:59:32.760533Z","steps":["trace[1118555931] 'process raft request' (duration: 158.387817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:00:48.123362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.582971ms","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-06T05:00:48.12344Z","caller":"traceutil/trace.go:171","msg":"trace[1057549862] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1808; }","duration":"137.724647ms","start":"2026-05-06T05:00:47.985697Z","end":"2026-05-06T05:00:48.123422Z","steps":["trace[1057549862] 'range keys from in-memory index tree' (duration: 137.380273ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:48.529415Z","caller":"traceutil/trace.go:171","msg":"trace[76656230] linearizableReadLoop","detail":"{readStateIndex:1879; appliedIndex:1878; }","duration":"170.054695ms","start":"2026-05-06T05:00:48.359335Z","end":"2026-05-06T05:00:48.52939Z","steps":["trace[76656230] 'read index received' (duration: 169.805444ms)","trace[76656230] 'applied index is now lower than readState.Index' (duration: 235.69µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:00:48.529552Z","caller":"traceutil/trace.go:171","msg":"trace[1947217227] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"186.654571ms","start":"2026-05-06T05:00:48.342883Z","end":"2026-05-06T05:00:48.529537Z","steps":["trace[1947217227] 'process raft request' (duration: 186.325007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:00:48.529819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.467892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-58a9c7eb-0c76-4d79-b513-2b23540eb006\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-05-06T05:00:48.530156Z","caller":"traceutil/trace.go:171","msg":"trace[330723406] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-58a9c7eb-0c76-4d79-b513-2b23540eb006; range_end:; response_count:1; response_revision:1809; }","duration":"170.567416ms","start":"2026-05-06T05:00:48.359296Z","end":"2026-05-06T05:00:48.529863Z","steps":["trace[330723406] 'agreement among raft nodes before linearized reading' (duration: 170.347867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:01:03.425337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.07976ms","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-06T05:01:03.425399Z","caller":"traceutil/trace.go:171","msg":"trace[1982013246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1940; }","duration":"143.218856ms","start":"2026-05-06T05:01:03.282167Z","end":"2026-05-06T05:01:03.425386Z","steps":["trace[1982013246] 'range keys from in-memory index tree' (duration: 142.988757ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:01:03.425774Z","caller":"traceutil/trace.go:171","msg":"trace[1264565742] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"141.137043ms","start":"2026-05-06T05:01:03.28463Z","end":"2026-05-06T05:01:03.425767Z","steps":["trace[1264565742] 'process raft request' (duration: 140.435657ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:01:21.352451Z","caller":"traceutil/trace.go:171","msg":"trace[6380145] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"111.530311ms","start":"2026-05-06T05:01:21.240902Z","end":"2026-05-06T05:01:21.352433Z","steps":["trace[6380145] 'process raft request' (duration: 105.019828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:01:21.716488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.524134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-06T05:01:21.71683Z","caller":"traceutil/trace.go:171","msg":"trace[2145799887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2044; }","duration":"201.915226ms","start":"2026-05-06T05:01:21.514887Z","end":"2026-05-06T05:01:21.716802Z","steps":["trace[2145799887] 'range keys from in-memory index tree' (duration: 201.332859ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:01:21.717573Z","caller":"traceutil/trace.go:171","msg":"trace[2068912853] linearizableReadLoop","detail":"{readStateIndex:2123; appliedIndex:2122; }","duration":"135.698626ms","start":"2026-05-06T05:01:21.581848Z","end":"2026-05-06T05:01:21.717546Z","steps":["trace[2068912853] 'read index received' (duration: 135.518131ms)","trace[2068912853] 'applied index is now lower than readState.Index' (duration: 178.965µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:01:21.717645Z","caller":"traceutil/trace.go:171","msg":"trace[685519905] transaction","detail":"{read_only:false; response_revision:2045; number_of_response:1; }","duration":"150.937017ms","start":"2026-05-06T05:01:21.566683Z","end":"2026-05-06T05:01:21.71762Z","steps":["trace[685519905] 'process raft request' (duration: 150.698941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:01:21.717795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.933003ms","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-06T05:01:21.717854Z","caller":"traceutil/trace.go:171","msg":"trace[1089518165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2045; }","duration":"136.039296ms","start":"2026-05-06T05:01:21.581796Z","end":"2026-05-06T05:01:21.717836Z","steps":["trace[1089518165] 'agreement among raft nodes before linearized reading' (duration: 135.85557ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:01:22.152143Z","caller":"traceutil/trace.go:171","msg":"trace[918534156] transaction","detail":"{read_only:false; response_revision:2048; number_of_response:1; }","duration":"264.56765ms","start":"2026-05-06T05:01:21.887551Z","end":"2026-05-06T05:01:22.152119Z","steps":["trace[918534156] 'process raft request' (duration: 264.304162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:01:22.558984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.996768ms","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-06T05:01:22.55982Z","caller":"traceutil/trace.go:171","msg":"trace[489221690] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2048; }","duration":"197.819191ms","start":"2026-05-06T05:01:22.361915Z","end":"2026-05-06T05:01:22.559734Z","steps":["trace[489221690] 'range keys from in-memory index tree' (duration: 196.614517ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:24.647677Z","caller":"traceutil/trace.go:171","msg":"trace[673096253] transaction","detail":"{read_only:false; response_revision:2488; number_of_response:1; }","duration":"276.057454ms","start":"2026-05-06T05:02:24.371597Z","end":"2026-05-06T05:02:24.647655Z","steps":["trace[673096253] 'process raft request' (duration: 275.921881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:02:24.973175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.709926ms","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-06T05:02:24.973248Z","caller":"traceutil/trace.go:171","msg":"trace[1820454932] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2488; }","duration":"121.903129ms","start":"2026-05-06T05:02:24.851327Z","end":"2026-05-06T05:02:24.973231Z","steps":["trace[1820454932] 'range keys from in-memory index tree' (duration: 121.518771ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:58.400138Z","caller":"traceutil/trace.go:171","msg":"trace[795899864] transaction","detail":"{read_only:false; response_revision:2674; number_of_response:1; }","duration":"155.634792ms","start":"2026-05-06T05:02:58.244483Z","end":"2026-05-06T05:02:58.400118Z","steps":["trace[795899864] 'process raft request' (duration: 155.49384ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:02:58.481377Z","caller":"traceutil/trace.go:171","msg":"trace[1746208954] transaction","detail":"{read_only:false; response_revision:2675; number_of_response:1; }","duration":"236.0835ms","start":"2026-05-06T05:02:58.245264Z","end":"2026-05-06T05:02:58.481347Z","steps":["trace[1746208954] 'process raft request' (duration: 235.922507ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:05:08.08445Z","caller":"traceutil/trace.go:171","msg":"trace[330158287] transaction","detail":"{read_only:false; response_revision:3448; number_of_response:1; }","duration":"130.830816ms","start":"2026-05-06T05:05:07.95359Z","end":"2026-05-06T05:05:08.08442Z","steps":["trace[330158287] 'process raft request' (duration: 119.170231ms)","trace[330158287] 'compare' (duration: 11.53184ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:37.714066Z","caller":"traceutil/trace.go:171","msg":"trace[1452890436] linearizableReadLoop","detail":"{readStateIndex:4618; appliedIndex:4617; }","duration":"232.458637ms","start":"2026-05-06T05:06:37.481584Z","end":"2026-05-06T05:06:37.714043Z","steps":["trace[1452890436] 'read index received' (duration: 232.396616ms)","trace[1452890436] 'applied index is now lower than readState.Index' (duration: 61.081µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:37.714172Z","caller":"traceutil/trace.go:171","msg":"trace[1457779353] transaction","detail":"{read_only:false; response_revision:4450; number_of_response:1; }","duration":"241.930303ms","start":"2026-05-06T05:06:37.472232Z","end":"2026-05-06T05:06:37.714162Z","steps":["trace[1457779353] 'process raft request' (duration: 241.674936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:37.714484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.878339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-06T05:06:37.714533Z","caller":"traceutil/trace.go:171","msg":"trace[1653163566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4450; }","duration":"232.957851ms","start":"2026-05-06T05:06:37.481564Z","end":"2026-05-06T05:06:37.714522Z","steps":["trace[1653163566] 'agreement among raft nodes before linearized reading' (duration: 232.773796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:37.717003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.311507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1433"} {"level":"info","ts":"2026-05-06T05:06:37.717083Z","caller":"traceutil/trace.go:171","msg":"trace[22694780] range","detail":"{range_begin:/registry/clusterrolebindings/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4451; }","duration":"235.412609ms","start":"2026-05-06T05:06:37.481653Z","end":"2026-05-06T05:06:37.717065Z","steps":["trace[22694780] 'agreement among raft nodes before linearized reading' (duration: 235.157122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:37.717375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.600612ms","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-06T05:06:37.717411Z","caller":"traceutil/trace.go:171","msg":"trace[699718140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4451; }","duration":"185.648783ms","start":"2026-05-06T05:06:37.531753Z","end":"2026-05-06T05:06:37.717402Z","steps":["trace[699718140] 'agreement among raft nodes before linearized reading' (duration: 185.55975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:37.717592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.850596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:06:37.717638Z","caller":"traceutil/trace.go:171","msg":"trace[135275638] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:4451; }","duration":"219.922179ms","start":"2026-05-06T05:06:37.497697Z","end":"2026-05-06T05:06:37.717619Z","steps":["trace[135275638] 'agreement among raft nodes before linearized reading' (duration: 219.848797ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:39.753629Z","caller":"traceutil/trace.go:171","msg":"trace[939832566] transaction","detail":"{read_only:false; response_revision:4507; number_of_response:1; }","duration":"118.594344ms","start":"2026-05-06T05:06:39.634998Z","end":"2026-05-06T05:06:39.753592Z","steps":["trace[939832566] 'process raft request' (duration: 118.512831ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:39.753671Z","caller":"traceutil/trace.go:171","msg":"trace[77667901] transaction","detail":"{read_only:false; response_revision:4506; number_of_response:1; }","duration":"118.710037ms","start":"2026-05-06T05:06:39.634918Z","end":"2026-05-06T05:06:39.753628Z","steps":["trace[77667901] 'process raft request' (duration: 101.351076ms)","trace[77667901] 'compare' (duration: 17.088923ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:39.753851Z","caller":"traceutil/trace.go:171","msg":"trace[355683161] transaction","detail":"{read_only:false; response_revision:4511; number_of_response:1; }","duration":"113.42133ms","start":"2026-05-06T05:06:39.640416Z","end":"2026-05-06T05:06:39.753837Z","steps":["trace[355683161] 'process raft request' (duration: 113.192684ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:39.754006Z","caller":"traceutil/trace.go:171","msg":"trace[805717552] transaction","detail":"{read_only:false; response_revision:4508; number_of_response:1; }","duration":"118.852811ms","start":"2026-05-06T05:06:39.635144Z","end":"2026-05-06T05:06:39.753996Z","steps":["trace[805717552] 'process raft request' (duration: 118.391048ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:39.754Z","caller":"traceutil/trace.go:171","msg":"trace[1068978827] transaction","detail":"{read_only:false; response_revision:4512; number_of_response:1; }","duration":"108.108403ms","start":"2026-05-06T05:06:39.645877Z","end":"2026-05-06T05:06:39.753985Z","steps":["trace[1068978827] 'process raft request' (duration: 107.777614ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:39.754096Z","caller":"traceutil/trace.go:171","msg":"trace[474568523] linearizableReadLoop","detail":"{readStateIndex:4681; appliedIndex:4676; }","duration":"117.366029ms","start":"2026-05-06T05:06:39.636722Z","end":"2026-05-06T05:06:39.754088Z","steps":["trace[474568523] 'read index received' (duration: 64.977759ms)","trace[474568523] 'applied index is now lower than readState.Index' (duration: 52.38771ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:39.754099Z","caller":"traceutil/trace.go:171","msg":"trace[68368682] transaction","detail":"{read_only:false; response_revision:4509; number_of_response:1; }","duration":"118.555041ms","start":"2026-05-06T05:06:39.635535Z","end":"2026-05-06T05:06:39.75409Z","steps":["trace[68368682] 'process raft request' (duration: 118.020987ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:39.754189Z","caller":"traceutil/trace.go:171","msg":"trace[335703920] transaction","detail":"{read_only:false; response_revision:4510; number_of_response:1; }","duration":"118.614984ms","start":"2026-05-06T05:06:39.635565Z","end":"2026-05-06T05:06:39.75418Z","steps":["trace[335703920] 'process raft request' (duration: 118.010837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:39.754327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.587375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:06:39.754367Z","caller":"traceutil/trace.go:171","msg":"trace[1700465933] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4513; }","duration":"117.662257ms","start":"2026-05-06T05:06:39.63669Z","end":"2026-05-06T05:06:39.754352Z","steps":["trace[1700465933] 'agreement among raft nodes before linearized reading' (duration: 117.536394ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:46.561267Z","caller":"traceutil/trace.go:171","msg":"trace[1122416733] linearizableReadLoop","detail":"{readStateIndex:4819; appliedIndex:4817; }","duration":"129.616997ms","start":"2026-05-06T05:06:46.431626Z","end":"2026-05-06T05:06:46.561243Z","steps":["trace[1122416733] 'read index received' (duration: 116.509982ms)","trace[1122416733] 'applied index is now lower than readState.Index' (duration: 13.106165ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:46.561415Z","caller":"traceutil/trace.go:171","msg":"trace[1843447233] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"148.473487ms","start":"2026-05-06T05:06:46.4129Z","end":"2026-05-06T05:06:46.561373Z","steps":["trace[1843447233] 'process raft request' (duration: 148.227451ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:46.561491Z","caller":"traceutil/trace.go:171","msg":"trace[1348801880] transaction","detail":"{read_only:false; response_revision:4643; number_of_response:1; }","duration":"154.212013ms","start":"2026-05-06T05:06:46.407253Z","end":"2026-05-06T05:06:46.561465Z","steps":["trace[1348801880] 'process raft request' (duration: 140.944343ms)","trace[1348801880] 'compare' (duration: 12.700095ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:06:46.561799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.399037ms","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":"warn","ts":"2026-05-06T05:06:46.561825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.206521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-05-06T05:06:46.561881Z","caller":"traceutil/trace.go:171","msg":"trace[1745356946] 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:4644; }","duration":"127.50379ms","start":"2026-05-06T05:06:46.43435Z","end":"2026-05-06T05:06:46.561854Z","steps":["trace[1745356946] 'agreement among raft nodes before linearized reading' (duration: 127.251883ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:46.561902Z","caller":"traceutil/trace.go:171","msg":"trace[1601788052] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4644; }","duration":"127.291204ms","start":"2026-05-06T05:06:46.434587Z","end":"2026-05-06T05:06:46.561878Z","steps":["trace[1601788052] 'agreement among raft nodes before linearized reading' (duration: 127.059447ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:46.562205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.558962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194894"} {"level":"info","ts":"2026-05-06T05:06:46.562247Z","caller":"traceutil/trace.go:171","msg":"trace[1883543565] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4644; }","duration":"130.645094ms","start":"2026-05-06T05:06:46.43159Z","end":"2026-05-06T05:06:46.562235Z","steps":["trace[1883543565] 'agreement among raft nodes before linearized reading' (duration: 129.782611ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:46.765644Z","caller":"traceutil/trace.go:171","msg":"trace[1920620814] transaction","detail":"{read_only:false; response_revision:4645; number_of_response:1; }","duration":"195.923272ms","start":"2026-05-06T05:06:46.569697Z","end":"2026-05-06T05:06:46.765621Z","steps":["trace[1920620814] 'process raft request' (duration: 149.567387ms)","trace[1920620814] 'compare' (duration: 46.251852ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:46.769353Z","caller":"traceutil/trace.go:171","msg":"trace[1060505057] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"199.179929ms","start":"2026-05-06T05:06:46.570151Z","end":"2026-05-06T05:06:46.769331Z","steps":["trace[1060505057] 'process raft request' (duration: 199.104107ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:46.769359Z","caller":"traceutil/trace.go:171","msg":"trace[359563258] transaction","detail":"{read_only:false; response_revision:4646; number_of_response:1; }","duration":"199.57371ms","start":"2026-05-06T05:06:46.569757Z","end":"2026-05-06T05:06:46.769331Z","steps":["trace[359563258] 'process raft request' (duration: 199.376054ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:46.769484Z","caller":"traceutil/trace.go:171","msg":"trace[1918607568] linearizableReadLoop","detail":"{readStateIndex:4823; appliedIndex:4819; }","duration":"197.242636ms","start":"2026-05-06T05:06:46.572218Z","end":"2026-05-06T05:06:46.769461Z","steps":["trace[1918607568] 'read index received' (duration: 147.111379ms)","trace[1918607568] 'applied index is now lower than readState.Index' (duration: 50.122627ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:46.769534Z","caller":"traceutil/trace.go:171","msg":"trace[1279484224] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"199.305273ms","start":"2026-05-06T05:06:46.570217Z","end":"2026-05-06T05:06:46.769522Z","steps":["trace[1279484224] 'process raft request' (duration: 199.066366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:46.769701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.462022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-5f29c995-4e97-4ce0-a563-6d128c07386b\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-06T05:06:46.769736Z","caller":"traceutil/trace.go:171","msg":"trace[534372110] range","detail":"{range_begin:/registry/persistentvolumes/pvc-5f29c995-4e97-4ce0-a563-6d128c07386b; range_end:; response_count:1; response_revision:4648; }","duration":"197.530524ms","start":"2026-05-06T05:06:46.572198Z","end":"2026-05-06T05:06:46.769729Z","steps":["trace[534372110] 'agreement among raft nodes before linearized reading' (duration: 197.35285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:46.774713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.602665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-05-06T05:06:46.774754Z","caller":"traceutil/trace.go:171","msg":"trace[2024501957] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4649; }","duration":"184.685447ms","start":"2026-05-06T05:06:46.590058Z","end":"2026-05-06T05:06:46.774743Z","steps":["trace[2024501957] 'agreement among raft nodes before linearized reading' (duration: 184.561214ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:47.113714Z","caller":"traceutil/trace.go:171","msg":"trace[1468897330] linearizableReadLoop","detail":"{readStateIndex:4828; appliedIndex:4827; }","duration":"111.846907ms","start":"2026-05-06T05:06:47.001825Z","end":"2026-05-06T05:06:47.113672Z","steps":["trace[1468897330] 'read index received' (duration: 50.107452ms)","trace[1468897330] 'applied index is now lower than readState.Index' (duration: 61.738375ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:47.11404Z","caller":"traceutil/trace.go:171","msg":"trace[1396257715] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"147.762439ms","start":"2026-05-06T05:06:46.966243Z","end":"2026-05-06T05:06:47.114005Z","steps":["trace[1396257715] 'process raft request' (duration: 85.784778ms)","trace[1396257715] 'compare' (duration: 61.495978ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:06:47.114157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.21048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-06T05:06:47.114215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.561522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-05-06T05:06:47.114225Z","caller":"traceutil/trace.go:171","msg":"trace[1477591234] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4653; }","duration":"138.315804ms","start":"2026-05-06T05:06:46.975896Z","end":"2026-05-06T05:06:47.114212Z","steps":["trace[1477591234] 'agreement among raft nodes before linearized reading' (duration: 138.106648ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:47.114259Z","caller":"traceutil/trace.go:171","msg":"trace[575690184] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4653; }","duration":"100.656934ms","start":"2026-05-06T05:06:47.013589Z","end":"2026-05-06T05:06:47.114246Z","steps":["trace[575690184] 'agreement among raft nodes before linearized reading' (duration: 100.4888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:58.221744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.095691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:06:58.221886Z","caller":"traceutil/trace.go:171","msg":"trace[59104616] transaction","detail":"{read_only:false; response_revision:4815; number_of_response:1; }","duration":"198.830982ms","start":"2026-05-06T05:06:58.023014Z","end":"2026-05-06T05:06:58.221845Z","steps":["trace[59104616] 'process raft request' (duration: 34.823068ms)","trace[59104616] 'compare' (duration: 162.897996ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:08:42.686251Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2906} {"level":"info","ts":"2026-05-06T05:08:42.787192Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2906,"took":"99.856701ms","hash":3404894711,"current-db-size-bytes":54693888,"current-db-size":"55 MB","current-db-size-in-use-bytes":29495296,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-06T05:08:42.7873Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3404894711,"revision":2906,"compact-revision":-1} {"level":"warn","ts":"2026-05-06T05:10:59.823759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.744456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:2 size:107263"} {"level":"info","ts":"2026-05-06T05:10:59.823824Z","caller":"traceutil/trace.go:171","msg":"trace[1788179908] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:6581; }","duration":"119.871748ms","start":"2026-05-06T05:10:59.703937Z","end":"2026-05-06T05:10:59.823809Z","steps":["trace[1788179908] 'range keys from in-memory index tree' (duration: 119.530473ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:13:42.691833Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5628} {"level":"info","ts":"2026-05-06T05:13:42.763095Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5628,"took":"69.553515ms","hash":329129432,"current-db-size-bytes":54693888,"current-db-size":"55 MB","current-db-size-in-use-bytes":18325504,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-06T05:13:42.763141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":329129432,"revision":5628,"compact-revision":2906}