{"level":"warn","ts":"2026-05-27T00:34:19.462796Z","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-27T00:34:19.462876Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35: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.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35: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-27T00:34:19.462932Z","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-27T00:34:19.462945Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-05-27T00:34:19.46296Z","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-27T00:34:19.463528Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-05-27T00:34:19.463606Z","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.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35: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-27T00:34:19.55643Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"92.622559ms"} {"level":"info","ts":"2026-05-27T00:34:19.56647Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-05-27T00:34:19.566561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T00:34:19.566602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-05-27T00:34:19.566615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T00:34:19.566631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-05-27T00:34:19.566716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-05-27T00:34:19.57318Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T00:34:19.574346Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T00:34:19.575266Z","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-27T00:34:19.577122Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T00:34:19.580642Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T00:34:19.580863Z","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-27T00:34:19.580941Z","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-27T00:34:19.58099Z","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-27T00:34:19.581491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-05-27T00:34:19.581593Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-05-27T00:34:19.582274Z","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-27T00:34:19.582477Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T00:34:19.582509Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T00:34:19.582576Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-05-27T00:34:19.582589Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-05-27T00:34:20.167198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T00:34:20.167249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T00:34:20.167279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-05-27T00:34:20.167293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-05-27T00:34:20.1673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-05-27T00:34:20.16731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-05-27T00:34:20.167319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-05-27T00:34:20.169396Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:34:20.174674Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T00:34:20.174926Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T00:34:20.175056Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T00:34:20.175255Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:34:20.175334Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:34:20.175358Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:34:20.178475Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"info","ts":"2026-05-27T00:34:20.17855Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T00:34:20.184854Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T00:34:20.184907Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-05-27T00:34:25.330485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.867633ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:34:25.330613Z","caller":"traceutil/trace.go:171","msg":"trace[2121876401] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"440.54627ms","start":"2026-05-27T00:34:24.890049Z","end":"2026-05-27T00:34:25.330595Z","steps":["trace[2121876401] 'process raft request' (duration: 247.096805ms)","trace[2121876401] 'compare' (duration: 192.741797ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:34:25.330723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:34:24.890021Z","time spent":"440.634845ms","remote":"127.0.0.1:46002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T00:34:25.331756Z","caller":"traceutil/trace.go:171","msg":"trace[918901570] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"364.921431ms","start":"2026-05-27T00:34:24.96682Z","end":"2026-05-27T00:34:25.331742Z","steps":["trace[918901570] 'process raft request' (duration: 364.884949ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:34:25.331846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:34:24.966799Z","time spent":"365.007485ms","remote":"127.0.0.1:46028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1933,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T00:34:25.332203Z","caller":"traceutil/trace.go:171","msg":"trace[1574483210] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"440.463415ms","start":"2026-05-27T00:34:24.891699Z","end":"2026-05-27T00:34:25.332162Z","steps":["trace[1574483210] 'process raft request' (duration: 439.927278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:34:25.332605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:34:24.891683Z","time spent":"440.568701ms","remote":"127.0.0.1:46086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4182,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:34:25.490559Z","caller":"traceutil/trace.go:171","msg":"trace[732854281] linearizableReadLoop","detail":"{readStateIndex:249; appliedIndex:248; }","duration":"144.987749ms","start":"2026-05-27T00:34:25.345537Z","end":"2026-05-27T00:34:25.490524Z","steps":["trace[732854281] 'read index received' (duration: 142.925742ms)","trace[732854281] 'applied index is now lower than readState.Index' (duration: 2.060227ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:34:25.490709Z","caller":"traceutil/trace.go:171","msg":"trace[1731494762] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"151.945858ms","start":"2026-05-27T00:34:25.338751Z","end":"2026-05-27T00:34:25.490697Z","steps":["trace[1731494762] 'process raft request' (duration: 149.626958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:34:25.490803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.134469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:34:25.490916Z","caller":"traceutil/trace.go:171","msg":"trace[967828694] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:238; }","duration":"106.301617ms","start":"2026-05-27T00:34:25.384587Z","end":"2026-05-27T00:34:25.490888Z","steps":["trace[967828694] 'agreement among raft nodes before linearized reading' (duration: 106.116718ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:34:25.491006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.439002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:34:25.491095Z","caller":"traceutil/trace.go:171","msg":"trace[5381401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:238; }","duration":"145.571028ms","start":"2026-05-27T00:34:25.34549Z","end":"2026-05-27T00:34:25.491061Z","steps":["trace[5381401] 'agreement among raft nodes before linearized reading' (duration: 145.423241ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:34:56.420835Z","caller":"traceutil/trace.go:171","msg":"trace[1191741654] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"102.639866ms","start":"2026-05-27T00:34:56.318176Z","end":"2026-05-27T00:34:56.420816Z","steps":["trace[1191741654] 'process raft request' (duration: 84.098154ms)","trace[1191741654] 'compare' (duration: 18.452646ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:34:56.433651Z","caller":"traceutil/trace.go:171","msg":"trace[214535089] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"112.143746ms","start":"2026-05-27T00:34:56.321485Z","end":"2026-05-27T00:34:56.433629Z","steps":["trace[214535089] 'process raft request' (duration: 111.917843ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:34:56.433802Z","caller":"traceutil/trace.go:171","msg":"trace[967210515] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"112.146807ms","start":"2026-05-27T00:34:56.321612Z","end":"2026-05-27T00:34:56.433759Z","steps":["trace[967210515] 'process raft request' (duration: 111.916093ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:34:56.433809Z","caller":"traceutil/trace.go:171","msg":"trace[99855606] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"111.107645ms","start":"2026-05-27T00:34:56.322667Z","end":"2026-05-27T00:34:56.433775Z","steps":["trace[99855606] 'process raft request' (duration: 110.931205ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:34:56.434025Z","caller":"traceutil/trace.go:171","msg":"trace[151343017] transaction","detail":"{read_only:false; number_of_response:1; response_revision:488; }","duration":"110.768604ms","start":"2026-05-27T00:34:56.32319Z","end":"2026-05-27T00:34:56.433959Z","steps":["trace[151343017] 'process raft request' (duration: 110.471067ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:34:56.434724Z","caller":"traceutil/trace.go:171","msg":"trace[1655721164] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"104.157725ms","start":"2026-05-27T00:34:56.330551Z","end":"2026-05-27T00:34:56.434708Z","steps":["trace[1655721164] 'process raft request' (duration: 103.782293ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:34:56.434843Z","caller":"traceutil/trace.go:171","msg":"trace[500245672] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"106.806572ms","start":"2026-05-27T00:34:56.328029Z","end":"2026-05-27T00:34:56.434835Z","steps":["trace[500245672] 'process raft request' (duration: 105.783302ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:34:56.435062Z","caller":"traceutil/trace.go:171","msg":"trace[341222376] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"105.280602ms","start":"2026-05-27T00:34:56.329772Z","end":"2026-05-27T00:34:56.435053Z","steps":["trace[341222376] 'process raft request' (duration: 104.516487ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:34:56.435222Z","caller":"traceutil/trace.go:171","msg":"trace[408229021] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"104.618503ms","start":"2026-05-27T00:34:56.33058Z","end":"2026-05-27T00:34:56.435198Z","steps":["trace[408229021] 'process raft request' (duration: 103.792473ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:35:01.067954Z","caller":"traceutil/trace.go:171","msg":"trace[1347812783] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"122.280398ms","start":"2026-05-27T00:35:00.945619Z","end":"2026-05-27T00:35:01.0679Z","steps":["trace[1347812783] 'process raft request' (duration: 120.821031ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:35:02.654986Z","caller":"traceutil/trace.go:171","msg":"trace[1510498708] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"101.091079ms","start":"2026-05-27T00:35:02.553875Z","end":"2026-05-27T00:35:02.654967Z","steps":["trace[1510498708] 'process raft request' (duration: 100.702026ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:35:02.828105Z","caller":"traceutil/trace.go:171","msg":"trace[483827752] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"113.417199ms","start":"2026-05-27T00:35:02.71466Z","end":"2026-05-27T00:35:02.828077Z","steps":["trace[483827752] 'process raft request' (duration: 81.223839ms)","trace[483827752] 'compare' (duration: 32.026289ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:35:03.310941Z","caller":"traceutil/trace.go:171","msg":"trace[969527666] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"321.401464ms","start":"2026-05-27T00:35:02.989513Z","end":"2026-05-27T00:35:03.310915Z","steps":["trace[969527666] 'read index received' (duration: 321.278706ms)","trace[969527666] 'applied index is now lower than readState.Index' (duration: 121.758µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:35:03.311001Z","caller":"traceutil/trace.go:171","msg":"trace[747045812] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"442.725665ms","start":"2026-05-27T00:35:02.868244Z","end":"2026-05-27T00:35:03.31097Z","steps":["trace[747045812] 'process raft request' (duration: 442.488141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:35:03.311076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.540332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:35:03.311132Z","caller":"traceutil/trace.go:171","msg":"trace[506318693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"321.66312ms","start":"2026-05-27T00:35:02.989451Z","end":"2026-05-27T00:35:03.311115Z","steps":["trace[506318693] 'agreement among raft nodes before linearized reading' (duration: 321.561613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:35:03.31118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:35:02.989435Z","time spent":"321.735574ms","remote":"127.0.0.1:45904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T00:35:03.311195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:35:02.868207Z","time spent":"442.902275ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:35:03.323778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.122524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-27T00:35:03.323856Z","caller":"traceutil/trace.go:171","msg":"trace[2091107958] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:1; response_revision:592; }","duration":"176.235842ms","start":"2026-05-27T00:35:03.147603Z","end":"2026-05-27T00:35:03.323839Z","steps":["trace[2091107958] 'agreement among raft nodes before linearized reading' (duration: 176.06351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:35:18.209435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.053684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-njjt4\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-05-27T00:35:18.209576Z","caller":"traceutil/trace.go:171","msg":"trace[664564275] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-njjt4; range_end:; response_count:1; response_revision:752; }","duration":"266.255107ms","start":"2026-05-27T00:35:17.943294Z","end":"2026-05-27T00:35:18.209549Z","steps":["trace[664564275] 'range keys from in-memory index tree' (duration: 265.771807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:35:18.209875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.550555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:35:18.209996Z","caller":"traceutil/trace.go:171","msg":"trace[1223898959] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:752; }","duration":"219.707135ms","start":"2026-05-27T00:35:17.99026Z","end":"2026-05-27T00:35:18.209967Z","steps":["trace[1223898959] 'range keys from in-memory index tree' (duration: 219.466219ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:14.35109Z","caller":"traceutil/trace.go:171","msg":"trace[38055824] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"119.533917ms","start":"2026-05-27T00:36:14.231525Z","end":"2026-05-27T00:36:14.351059Z","steps":["trace[38055824] 'process raft request' (duration: 119.307722ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:38.458352Z","caller":"traceutil/trace.go:171","msg":"trace[741245481] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"288.435335ms","start":"2026-05-27T00:36:38.1699Z","end":"2026-05-27T00:36:38.458335Z","steps":["trace[741245481] 'process raft request' (duration: 288.293225ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:38.504587Z","caller":"traceutil/trace.go:171","msg":"trace[1992960087] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"333.030949ms","start":"2026-05-27T00:36:38.171524Z","end":"2026-05-27T00:36:38.504555Z","steps":["trace[1992960087] 'process raft request' (duration: 332.778131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:36:38.504842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:36:38.171509Z","time spent":"333.159987ms","remote":"127.0.0.1:46174","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-27T00:36:38.516498Z","caller":"traceutil/trace.go:171","msg":"trace[739767320] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1910; }","duration":"260.627783ms","start":"2026-05-27T00:36:38.255846Z","end":"2026-05-27T00:36:38.516474Z","steps":["trace[739767320] 'read index received' (duration: 202.413232ms)","trace[739767320] 'applied index is now lower than readState.Index' (duration: 58.213341ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:36:38.516828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.968795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f207b122-f6b7-44e5-ab3d-3abdda0bf527\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-05-27T00:36:38.51713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.365729ms","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-27T00:36:38.51718Z","caller":"traceutil/trace.go:171","msg":"trace[1612830211] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1838; }","duration":"171.457946ms","start":"2026-05-27T00:36:38.345709Z","end":"2026-05-27T00:36:38.517167Z","steps":["trace[1612830211] 'agreement among raft nodes before linearized reading' (duration: 171.323746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:36:38.517348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.899865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"} {"level":"info","ts":"2026-05-27T00:36:38.517427Z","caller":"traceutil/trace.go:171","msg":"trace[1056180654] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f207b122-f6b7-44e5-ab3d-3abdda0bf527; range_end:; response_count:1; response_revision:1838; }","duration":"261.064712ms","start":"2026-05-27T00:36:38.255815Z","end":"2026-05-27T00:36:38.51688Z","steps":["trace[1056180654] 'agreement among raft nodes before linearized reading' (duration: 260.89005ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:38.517571Z","caller":"traceutil/trace.go:171","msg":"trace[1941593464] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1838; }","duration":"198.255339ms","start":"2026-05-27T00:36:38.319184Z","end":"2026-05-27T00:36:38.517439Z","steps":["trace[1941593464] 'agreement among raft nodes before linearized reading' (duration: 197.813819ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:38.654451Z","caller":"traceutil/trace.go:171","msg":"trace[938510329] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"126.803887ms","start":"2026-05-27T00:36:38.527621Z","end":"2026-05-27T00:36:38.654424Z","steps":["trace[938510329] 'process raft request' (duration: 126.739333ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:38.65449Z","caller":"traceutil/trace.go:171","msg":"trace[1168137321] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"130.993733ms","start":"2026-05-27T00:36:38.523459Z","end":"2026-05-27T00:36:38.654452Z","steps":["trace[1168137321] 'process raft request' (duration: 130.754237ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:38.835986Z","caller":"traceutil/trace.go:171","msg":"trace[216407710] linearizableReadLoop","detail":"{readStateIndex:1920; appliedIndex:1917; }","duration":"159.065202ms","start":"2026-05-27T00:36:38.676897Z","end":"2026-05-27T00:36:38.835962Z","steps":["trace[216407710] 'read index received' (duration: 138.722789ms)","trace[216407710] 'applied index is now lower than readState.Index' (duration: 20.341493ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:36:38.836148Z","caller":"traceutil/trace.go:171","msg":"trace[314532654] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"175.057691ms","start":"2026-05-27T00:36:38.661053Z","end":"2026-05-27T00:36:38.836111Z","steps":["trace[314532654] 'process raft request' (duration: 174.779832ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:38.836294Z","caller":"traceutil/trace.go:171","msg":"trace[1712132355] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"175.297297ms","start":"2026-05-27T00:36:38.660976Z","end":"2026-05-27T00:36:38.836273Z","steps":["trace[1712132355] 'process raft request' (duration: 154.626781ms)","trace[1712132355] 'compare' (duration: 19.923166ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:36:38.836305Z","caller":"traceutil/trace.go:171","msg":"trace[489658014] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"174.32096ms","start":"2026-05-27T00:36:38.661945Z","end":"2026-05-27T00:36:38.836266Z","steps":["trace[489658014] 'process raft request' (duration: 173.961676ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:36:38.836406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.490102ms","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-27T00:36:38.836461Z","caller":"traceutil/trace.go:171","msg":"trace[981929697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1845; }","duration":"159.617399ms","start":"2026-05-27T00:36:38.676831Z","end":"2026-05-27T00:36:38.836449Z","steps":["trace[981929697] 'agreement among raft nodes before linearized reading' (duration: 159.435717ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:38.919738Z","caller":"traceutil/trace.go:171","msg":"trace[1248604508] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"237.870994ms","start":"2026-05-27T00:36:38.68184Z","end":"2026-05-27T00:36:38.919711Z","steps":["trace[1248604508] 'process raft request' (duration: 237.682512ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:51.146257Z","caller":"traceutil/trace.go:171","msg":"trace[202512445] linearizableReadLoop","detail":"{readStateIndex:2022; appliedIndex:2021; }","duration":"154.883352ms","start":"2026-05-27T00:36:50.991341Z","end":"2026-05-27T00:36:51.146225Z","steps":["trace[202512445] 'read index received' (duration: 154.639396ms)","trace[202512445] 'applied index is now lower than readState.Index' (duration: 242.786µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:36:51.146737Z","caller":"traceutil/trace.go:171","msg":"trace[1637812487] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"159.890305ms","start":"2026-05-27T00:36:50.98683Z","end":"2026-05-27T00:36:51.146721Z","steps":["trace[1637812487] 'process raft request' (duration: 159.147935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:36:51.146978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.622703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:36:51.147021Z","caller":"traceutil/trace.go:171","msg":"trace[934953510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1945; }","duration":"155.71918ms","start":"2026-05-27T00:36:50.991289Z","end":"2026-05-27T00:36:51.147009Z","steps":["trace[934953510] 'agreement among raft nodes before linearized reading' (duration: 155.635334ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:51.157658Z","caller":"traceutil/trace.go:171","msg":"trace[1007433432] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"102.551711ms","start":"2026-05-27T00:36:51.055082Z","end":"2026-05-27T00:36:51.157634Z","steps":["trace[1007433432] 'process raft request' (duration: 102.322806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:36:51.157846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.474152ms","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-27T00:36:51.157958Z","caller":"traceutil/trace.go:171","msg":"trace[1808464568] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1946; }","duration":"150.649294ms","start":"2026-05-27T00:36:51.007275Z","end":"2026-05-27T00:36:51.157924Z","steps":["trace[1808464568] 'agreement among raft nodes before linearized reading' (duration: 150.336903ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:36:51.381413Z","caller":"traceutil/trace.go:171","msg":"trace[870720482] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"178.968882ms","start":"2026-05-27T00:36:51.202414Z","end":"2026-05-27T00:36:51.381383Z","steps":["trace[870720482] 'process raft request' (duration: 178.815782ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:37:06.819555Z","caller":"traceutil/trace.go:171","msg":"trace[1444422865] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"139.977577ms","start":"2026-05-27T00:37:06.679555Z","end":"2026-05-27T00:37:06.819532Z","steps":["trace[1444422865] 'process raft request' (duration: 137.168819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:37:12.966428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.575945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-27T00:37:12.966497Z","caller":"traceutil/trace.go:171","msg":"trace[1312966637] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2081; }","duration":"107.704472ms","start":"2026-05-27T00:37:12.858778Z","end":"2026-05-27T00:37:12.966482Z","steps":["trace[1312966637] 'range keys from in-memory index tree' (duration: 107.37625ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:37:12.966709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.812961ms","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-27T00:37:12.966745Z","caller":"traceutil/trace.go:171","msg":"trace[1980749219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2081; }","duration":"124.889629ms","start":"2026-05-27T00:37:12.841848Z","end":"2026-05-27T00:37:12.966737Z","steps":["trace[1980749219] 'range keys from in-memory index tree' (duration: 124.695433ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:37:13.134096Z","caller":"traceutil/trace.go:171","msg":"trace[1573730236] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"163.162616ms","start":"2026-05-27T00:37:12.970904Z","end":"2026-05-27T00:37:13.134067Z","steps":["trace[1573730236] 'process raft request' (duration: 162.963561ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:37:13.14553Z","caller":"traceutil/trace.go:171","msg":"trace[2048929965] linearizableReadLoop","detail":"{readStateIndex:2164; appliedIndex:2162; }","duration":"171.847524ms","start":"2026-05-27T00:37:12.973656Z","end":"2026-05-27T00:37:13.145504Z","steps":["trace[2048929965] 'read index received' (duration: 160.129252ms)","trace[2048929965] 'applied index is now lower than readState.Index' (duration: 11.717502ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:37:13.145645Z","caller":"traceutil/trace.go:171","msg":"trace[1081396458] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"174.621813ms","start":"2026-05-27T00:37:12.971015Z","end":"2026-05-27T00:37:13.145637Z","steps":["trace[1081396458] 'process raft request' (duration: 174.388778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:37:13.146098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.420413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:37:13.146146Z","caller":"traceutil/trace.go:171","msg":"trace[34464240] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2083; }","duration":"172.520121ms","start":"2026-05-27T00:37:12.973612Z","end":"2026-05-27T00:37:13.146132Z","steps":["trace[34464240] 'agreement among raft nodes before linearized reading' (duration: 172.436892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:37:13.60362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.53687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:37:13.603846Z","caller":"traceutil/trace.go:171","msg":"trace[2097311605] linearizableReadLoop","detail":"{readStateIndex:2169; appliedIndex:2168; }","duration":"292.316734ms","start":"2026-05-27T00:37:13.311513Z","end":"2026-05-27T00:37:13.60383Z","steps":["trace[2097311605] 'read index received' (duration: 102.434082ms)","trace[2097311605] 'applied index is now lower than readState.Index' (duration: 189.881342ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:37:13.603955Z","caller":"traceutil/trace.go:171","msg":"trace[759978384] transaction","detail":"{read_only:false; response_revision:2087; number_of_response:1; }","duration":"348.494665ms","start":"2026-05-27T00:37:13.255365Z","end":"2026-05-27T00:37:13.60386Z","steps":["trace[759978384] 'process raft request' (duration: 158.638882ms)","trace[759978384] 'compare' (duration: 189.435022ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:37:13.604171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:37:13.255351Z","time spent":"348.73097ms","remote":"127.0.0.1:46174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:37:13.604318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.806993ms","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-27T00:37:13.60439Z","caller":"traceutil/trace.go:171","msg":"trace[76005234] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2087; }","duration":"292.915201ms","start":"2026-05-27T00:37:13.311463Z","end":"2026-05-27T00:37:13.604378Z","steps":["trace[76005234] 'agreement among raft nodes before linearized reading' (duration: 292.442501ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:37:13.608085Z","caller":"traceutil/trace.go:171","msg":"trace[1434165366] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"152.688999ms","start":"2026-05-27T00:37:13.455366Z","end":"2026-05-27T00:37:13.608055Z","steps":["trace[1434165366] 'process raft request' (duration: 152.551001ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:37:13.648321Z","caller":"traceutil/trace.go:171","msg":"trace[1075533646] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"190.586526ms","start":"2026-05-27T00:37:13.457675Z","end":"2026-05-27T00:37:13.648261Z","steps":["trace[1075533646] 'process raft request' (duration: 190.303512ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:38:17.742827Z","caller":"traceutil/trace.go:171","msg":"trace[1509898821] transaction","detail":"{read_only:false; response_revision:2533; number_of_response:1; }","duration":"170.298271ms","start":"2026-05-27T00:38:17.572497Z","end":"2026-05-27T00:38:17.742796Z","steps":["trace[1509898821] 'process raft request' (duration: 170.100929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:38:50.268435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.004192ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:38:50.268603Z","caller":"traceutil/trace.go:171","msg":"trace[270377987] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"106.174408ms","start":"2026-05-27T00:38:50.162411Z","end":"2026-05-27T00:38:50.268585Z","steps":["trace[270377987] 'process raft request' (duration: 106.117717ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:38:50.268889Z","caller":"traceutil/trace.go:171","msg":"trace[2030507259] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"238.32227ms","start":"2026-05-27T00:38:50.030338Z","end":"2026-05-27T00:38:50.26866Z","steps":["trace[2030507259] 'process raft request' (duration: 105.017342ms)","trace[2030507259] 'compare' (duration: 132.864649ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:42:28.878374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.115157ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-27T00:42:28.878622Z","caller":"traceutil/trace.go:171","msg":"trace[320279281] transaction","detail":"{read_only:false; response_revision:4391; number_of_response:1; }","duration":"183.79196ms","start":"2026-05-27T00:42:28.694818Z","end":"2026-05-27T00:42:28.87861Z","steps":["trace[320279281] 'process raft request' (duration: 183.651813ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:28.915275Z","caller":"traceutil/trace.go:171","msg":"trace[2048110712] transaction","detail":"{read_only:false; response_revision:4392; number_of_response:1; }","duration":"179.403433ms","start":"2026-05-27T00:42:28.735845Z","end":"2026-05-27T00:42:28.915248Z","steps":["trace[2048110712] 'process raft request' (duration: 178.834604ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:28.91569Z","caller":"traceutil/trace.go:171","msg":"trace[1424897285] transaction","detail":"{read_only:false; response_revision:4393; number_of_response:1; }","duration":"119.708164ms","start":"2026-05-27T00:42:28.795927Z","end":"2026-05-27T00:42:28.915635Z","steps":["trace[1424897285] 'process raft request' (duration: 119.24507ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:28.916127Z","caller":"traceutil/trace.go:171","msg":"trace[1464324958] transaction","detail":"{read_only:false; response_revision:4394; number_of_response:1; }","duration":"115.321057ms","start":"2026-05-27T00:42:28.800719Z","end":"2026-05-27T00:42:28.91604Z","steps":["trace[1464324958] 'process raft request' (duration: 114.638501ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:31.179256Z","caller":"traceutil/trace.go:171","msg":"trace[264801253] transaction","detail":"{read_only:false; response_revision:4431; number_of_response:1; }","duration":"105.954976ms","start":"2026-05-27T00:42:31.073278Z","end":"2026-05-27T00:42:31.179233Z","steps":["trace[264801253] 'process raft request' (duration: 57.551556ms)","trace[264801253] 'compare' (duration: 48.198909ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:42:31.181806Z","caller":"traceutil/trace.go:171","msg":"trace[1542136606] transaction","detail":"{read_only:false; response_revision:4434; number_of_response:1; }","duration":"100.113372ms","start":"2026-05-27T00:42:31.081672Z","end":"2026-05-27T00:42:31.181786Z","steps":["trace[1542136606] 'process raft request' (duration: 100.053358ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:31.182368Z","caller":"traceutil/trace.go:171","msg":"trace[1310501652] transaction","detail":"{read_only:false; response_revision:4432; number_of_response:1; }","duration":"101.96192ms","start":"2026-05-27T00:42:31.080271Z","end":"2026-05-27T00:42:31.182233Z","steps":["trace[1310501652] 'process raft request' (duration: 101.305195ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:31.185566Z","caller":"traceutil/trace.go:171","msg":"trace[454132076] transaction","detail":"{read_only:false; response_revision:4433; number_of_response:1; }","duration":"104.25307ms","start":"2026-05-27T00:42:31.081301Z","end":"2026-05-27T00:42:31.185554Z","steps":["trace[454132076] 'process raft request' (duration: 100.390678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:42:41.231232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.333566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12972"} {"level":"info","ts":"2026-05-27T00:42:41.231357Z","caller":"traceutil/trace.go:171","msg":"trace[1335685806] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4634; }","duration":"261.500395ms","start":"2026-05-27T00:42:40.969838Z","end":"2026-05-27T00:42:41.231338Z","steps":["trace[1335685806] 'range keys from in-memory index tree' (duration: 261.180258ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:41.231683Z","caller":"traceutil/trace.go:171","msg":"trace[920887772] transaction","detail":"{read_only:false; response_revision:4635; number_of_response:1; }","duration":"257.359226ms","start":"2026-05-27T00:42:40.974288Z","end":"2026-05-27T00:42:41.231647Z","steps":["trace[920887772] 'process raft request' (duration: 252.820167ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:41.256974Z","caller":"traceutil/trace.go:171","msg":"trace[1112093530] transaction","detail":"{read_only:false; response_revision:4637; number_of_response:1; }","duration":"276.609298ms","start":"2026-05-27T00:42:40.980331Z","end":"2026-05-27T00:42:41.25694Z","steps":["trace[1112093530] 'process raft request' (duration: 276.524014ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:41.256987Z","caller":"traceutil/trace.go:171","msg":"trace[1763175131] transaction","detail":"{read_only:false; response_revision:4636; number_of_response:1; }","duration":"281.542768ms","start":"2026-05-27T00:42:40.975397Z","end":"2026-05-27T00:42:41.25694Z","steps":["trace[1763175131] 'process raft request' (duration: 281.209731ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:41.257245Z","caller":"traceutil/trace.go:171","msg":"trace[741396987] linearizableReadLoop","detail":"{readStateIndex:4819; appliedIndex:4815; }","duration":"267.572335ms","start":"2026-05-27T00:42:40.98966Z","end":"2026-05-27T00:42:41.257232Z","steps":["trace[741396987] 'read index received' (duration: 237.463432ms)","trace[741396987] 'applied index is now lower than readState.Index' (duration: 30.107553ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:42:41.257374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.68502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:42:41.257414Z","caller":"traceutil/trace.go:171","msg":"trace[110609646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4638; }","duration":"267.778936ms","start":"2026-05-27T00:42:40.989624Z","end":"2026-05-27T00:42:41.257403Z","steps":["trace[110609646] 'agreement among raft nodes before linearized reading' (duration: 267.689351ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:41.257465Z","caller":"traceutil/trace.go:171","msg":"trace[2129177968] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"276.953997ms","start":"2026-05-27T00:42:40.98041Z","end":"2026-05-27T00:42:41.257364Z","steps":["trace[2129177968] 'process raft request' (duration: 276.484612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:42:41.320276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.534467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-27T00:42:41.320279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.225924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-27T00:42:41.320329Z","caller":"traceutil/trace.go:171","msg":"trace[1260015130] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4639; }","duration":"101.632282ms","start":"2026-05-27T00:42:41.218684Z","end":"2026-05-27T00:42:41.320317Z","steps":["trace[1260015130] 'agreement among raft nodes before linearized reading' (duration: 101.478984ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:41.32034Z","caller":"traceutil/trace.go:171","msg":"trace[1083389309] 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:4639; }","duration":"317.326389ms","start":"2026-05-27T00:42:41.002999Z","end":"2026-05-27T00:42:41.320325Z","steps":["trace[1083389309] 'agreement among raft nodes before linearized reading' (duration: 317.162861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:42:41.320369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:42:41.002987Z","time spent":"317.375072ms","remote":"127.0.0.1:46072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-05-27T00:42:41.859313Z","caller":"traceutil/trace.go:171","msg":"trace[2012324210] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"150.805827ms","start":"2026-05-27T00:42:41.708474Z","end":"2026-05-27T00:42:41.85928Z","steps":["trace[2012324210] 'process raft request' (duration: 150.593056ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:54.305871Z","caller":"traceutil/trace.go:171","msg":"trace[2120508241] linearizableReadLoop","detail":"{readStateIndex:5063; appliedIndex:5062; }","duration":"200.245035ms","start":"2026-05-27T00:42:54.105606Z","end":"2026-05-27T00:42:54.305851Z","steps":["trace[2120508241] 'read index received' (duration: 200.091046ms)","trace[2120508241] 'applied index is now lower than readState.Index' (duration: 153.179µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:42:54.306146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.527699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-27T00:42:54.306183Z","caller":"traceutil/trace.go:171","msg":"trace[694443261] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4876; }","duration":"200.595413ms","start":"2026-05-27T00:42:54.105572Z","end":"2026-05-27T00:42:54.306167Z","steps":["trace[694443261] 'agreement among raft nodes before linearized reading' (duration: 200.359581ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:42:54.306228Z","caller":"traceutil/trace.go:171","msg":"trace[1786919715] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"209.839124ms","start":"2026-05-27T00:42:54.096365Z","end":"2026-05-27T00:42:54.306204Z","steps":["trace[1786919715] 'process raft request' (duration: 209.360229ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:44:20.203696Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2872} {"level":"info","ts":"2026-05-27T00:44:20.286619Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2872,"took":"80.642064ms","hash":280539694,"current-db-size-bytes":54521856,"current-db-size":"54 MB","current-db-size-in-use-bytes":29630464,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-27T00:44:20.2867Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":280539694,"revision":2872,"compact-revision":-1} {"level":"info","ts":"2026-05-27T00:47:06.437388Z","caller":"traceutil/trace.go:171","msg":"trace[688668990] linearizableReadLoop","detail":"{readStateIndex:6942; appliedIndex:6941; }","duration":"152.602096ms","start":"2026-05-27T00:47:06.284758Z","end":"2026-05-27T00:47:06.43736Z","steps":["trace[688668990] 'read index received' (duration: 76.016225ms)","trace[688668990] 'applied index is now lower than readState.Index' (duration: 76.584881ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:47:06.437509Z","caller":"traceutil/trace.go:171","msg":"trace[1378373279] transaction","detail":"{read_only:false; response_revision:6694; number_of_response:1; }","duration":"181.121329ms","start":"2026-05-27T00:47:06.256352Z","end":"2026-05-27T00:47:06.437473Z","steps":["trace[1378373279] 'process raft request' (duration: 104.395397ms)","trace[1378373279] 'compare' (duration: 76.427038ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:47:06.437713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.920049ms","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-27T00:47:06.437746Z","caller":"traceutil/trace.go:171","msg":"trace[1547185037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6694; }","duration":"153.02124ms","start":"2026-05-27T00:47:06.284716Z","end":"2026-05-27T00:47:06.437738Z","steps":["trace[1547185037] 'agreement among raft nodes before linearized reading' (duration: 152.864758ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:47:06.451656Z","caller":"traceutil/trace.go:171","msg":"trace[2141614161] transaction","detail":"{read_only:false; response_revision:6695; number_of_response:1; }","duration":"102.463377ms","start":"2026-05-27T00:47:06.349174Z","end":"2026-05-27T00:47:06.451637Z","steps":["trace[2141614161] 'process raft request' (duration: 102.360166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:47:06.452645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.559978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:25 size:449571"} {"level":"info","ts":"2026-05-27T00:47:06.452717Z","caller":"traceutil/trace.go:171","msg":"trace[1635590399] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:25; response_revision:6695; }","duration":"165.66498ms","start":"2026-05-27T00:47:06.287038Z","end":"2026-05-27T00:47:06.452703Z","steps":["trace[1635590399] 'agreement among raft nodes before linearized reading' (duration: 165.098894ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:49:20.208698Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5598} {"level":"info","ts":"2026-05-27T00:49:20.279118Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5598,"took":"69.266828ms","hash":863195897,"current-db-size-bytes":54521856,"current-db-size":"54 MB","current-db-size-in-use-bytes":18272256,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-27T00:49:20.279165Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":863195897,"revision":5598,"compact-revision":2872}