{"level":"warn","ts":"2026-09-23T10:27:55.197764Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-23T10:27:55.197858Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.75: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://162.253.55.75:2380","--initial-cluster=instance=https://162.253.55.75:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.75:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.75: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-09-23T10:27:55.197918Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-23T10:27:55.197929Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.75:2380"]} {"level":"info","ts":"2026-09-23T10:27:55.197948Z","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-09-23T10:27:55.198595Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"]} {"level":"info","ts":"2026-09-23T10:27:55.198671Z","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://162.253.55.75:2380"],"listen-peer-urls":["https://162.253.55.75:2380"],"advertise-client-urls":["https://162.253.55.75:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.75: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-09-23T10:27:55.202682Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.769918ms"} {"level":"info","ts":"2026-09-23T10:27:55.212672Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"871515da6373d131","cluster-id":"1ca87f0850671e76"} {"level":"info","ts":"2026-09-23T10:27:55.212807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=()"} {"level":"info","ts":"2026-09-23T10:27:55.21283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became follower at term 0"} {"level":"info","ts":"2026-09-23T10:27:55.212865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 871515da6373d131 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-23T10:27:55.212879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became follower at term 1"} {"level":"info","ts":"2026-09-23T10:27:55.212939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=(9733710197346783537)"} {"level":"warn","ts":"2026-09-23T10:27:55.219275Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-23T10:27:55.220782Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-23T10:27:55.222806Z","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-09-23T10:27:55.225297Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"871515da6373d131","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-23T10:27:55.225717Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"871515da6373d131","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-23T10:27:55.22575Z","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-09-23T10:27:55.225894Z","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-09-23T10:27:55.225917Z","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-09-23T10:27:55.235245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=(9733710197346783537)"} {"level":"info","ts":"2026-09-23T10:27:55.235512Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1ca87f0850671e76","local-member-id":"871515da6373d131","added-peer-id":"871515da6373d131","added-peer-peer-urls":["https://162.253.55.75:2380"]} {"level":"info","ts":"2026-09-23T10:27:55.236265Z","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-09-23T10:27:55.236558Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.75:2380"} {"level":"info","ts":"2026-09-23T10:27:55.236629Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"871515da6373d131","initial-advertise-peer-urls":["https://162.253.55.75:2380"],"listen-peer-urls":["https://162.253.55.75:2380"],"advertise-client-urls":["https://162.253.55.75:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-23T10:27:55.236683Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-23T10:27:55.236638Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.75:2380"} {"level":"info","ts":"2026-09-23T10:27:55.313209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 is starting a new election at term 1"} {"level":"info","ts":"2026-09-23T10:27:55.313267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-23T10:27:55.313286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 received MsgPreVoteResp from 871515da6373d131 at term 1"} {"level":"info","ts":"2026-09-23T10:27:55.313301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became candidate at term 2"} {"level":"info","ts":"2026-09-23T10:27:55.313309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 received MsgVoteResp from 871515da6373d131 at term 2"} {"level":"info","ts":"2026-09-23T10:27:55.313344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became leader at term 2"} {"level":"info","ts":"2026-09-23T10:27:55.313354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 871515da6373d131 elected leader 871515da6373d131 at term 2"} {"level":"info","ts":"2026-09-23T10:27:55.314391Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-23T10:27:55.315275Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"871515da6373d131","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.75:2379]}","request-path":"/0/members/871515da6373d131/attributes","cluster-id":"1ca87f0850671e76","publish-timeout":"7s"} {"level":"info","ts":"2026-09-23T10:27:55.315523Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-23T10:27:55.315677Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-23T10:27:55.315847Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1ca87f0850671e76","local-member-id":"871515da6373d131","cluster-version":"3.5"} {"level":"info","ts":"2026-09-23T10:27:55.316011Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-23T10:27:55.316057Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-23T10:27:55.316778Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-23T10:27:55.316808Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-23T10:27:55.318695Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.75:2379"} {"level":"info","ts":"2026-09-23T10:27:55.31872Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-23T10:28:14.876114Z","caller":"traceutil/trace.go:171","msg":"trace[141895751] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"134.070691ms","start":"2026-09-23T10:28:14.74202Z","end":"2026-09-23T10:28:14.876091Z","steps":["trace[141895751] 'process raft request' (duration: 133.928547ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:28:15.369866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.296227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-23T10:28:15.370012Z","caller":"traceutil/trace.go:171","msg":"trace[2071249783] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"459.863537ms","start":"2026-09-23T10:28:14.910132Z","end":"2026-09-23T10:28:15.369996Z","steps":["trace[2071249783] 'process raft request' (duration: 89.686134ms)","trace[2071249783] 'compare' (duration: 369.168743ms)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:28:15.370069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.235512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:28:15.370007Z","caller":"traceutil/trace.go:171","msg":"trace[1501053435] linearizableReadLoop","detail":"{readStateIndex:393; appliedIndex:392; }","duration":"430.15339ms","start":"2026-09-23T10:28:14.939835Z","end":"2026-09-23T10:28:15.369988Z","steps":["trace[1501053435] 'read index received' (duration: 59.991548ms)","trace[1501053435] 'applied index is now lower than readState.Index' (duration: 370.160452ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:28:15.370123Z","caller":"traceutil/trace.go:171","msg":"trace[1748573676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"430.324695ms","start":"2026-09-23T10:28:14.939787Z","end":"2026-09-23T10:28:15.370111Z","steps":["trace[1748573676] 'agreement among raft nodes before linearized reading' (duration: 430.246513ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:28:15.37007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:28:14.910116Z","time spent":"459.929298ms","remote":"127.0.0.1:48422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-23T10:28:15.370162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:28:14.939766Z","time spent":"430.386857ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-23T10:28:41.390415Z","caller":"traceutil/trace.go:171","msg":"trace[1681937411] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"110.894974ms","start":"2026-09-23T10:28:41.279502Z","end":"2026-09-23T10:28:41.390397Z","steps":["trace[1681937411] 'process raft request' (duration: 20.774547ms)","trace[1681937411] 'compare' (duration: 90.005174ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:28:41.405532Z","caller":"traceutil/trace.go:171","msg":"trace[1551652703] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"111.991256ms","start":"2026-09-23T10:28:41.293495Z","end":"2026-09-23T10:28:41.405487Z","steps":["trace[1551652703] 'process raft request' (duration: 111.77216ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:28:41.479173Z","caller":"traceutil/trace.go:171","msg":"trace[1494363129] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"152.736306ms","start":"2026-09-23T10:28:41.326412Z","end":"2026-09-23T10:28:41.479149Z","steps":["trace[1494363129] 'process raft request' (duration: 152.452328ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:28:41.479427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.522458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-23T10:28:41.479715Z","caller":"traceutil/trace.go:171","msg":"trace[1452935461] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:578; }","duration":"130.849188ms","start":"2026-09-23T10:28:41.348847Z","end":"2026-09-23T10:28:41.479696Z","steps":["trace[1452935461] 'agreement among raft nodes before linearized reading' (duration: 130.469717ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:28:49.259861Z","caller":"traceutil/trace.go:171","msg":"trace[1745656] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"149.959163ms","start":"2026-09-23T10:28:49.109882Z","end":"2026-09-23T10:28:49.259841Z","steps":["trace[1745656] 'process raft request' (duration: 149.85746ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:28:49.616892Z","caller":"traceutil/trace.go:171","msg":"trace[941837558] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"253.273348ms","start":"2026-09-23T10:28:49.363605Z","end":"2026-09-23T10:28:49.616878Z","steps":["trace[941837558] 'process raft request' (duration: 252.99421ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:28:50.175804Z","caller":"traceutil/trace.go:171","msg":"trace[542723423] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:698; }","duration":"260.551736ms","start":"2026-09-23T10:28:49.915228Z","end":"2026-09-23T10:28:50.17578Z","steps":["trace[542723423] 'read index received' (duration: 260.422342ms)","trace[542723423] 'applied index is now lower than readState.Index' (duration: 128.274µs)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:28:50.17585Z","caller":"traceutil/trace.go:171","msg":"trace[1562911283] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"294.654425ms","start":"2026-09-23T10:28:49.881153Z","end":"2026-09-23T10:28:50.175808Z","steps":["trace[1562911283] 'process raft request' (duration: 294.451739ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:28:50.175998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.748252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:28:50.176052Z","caller":"traceutil/trace.go:171","msg":"trace[100263986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:675; }","duration":"260.856845ms","start":"2026-09-23T10:28:49.915181Z","end":"2026-09-23T10:28:50.176038Z","steps":["trace[100263986] 'agreement among raft nodes before linearized reading' (duration: 260.696321ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:29:37.725935Z","caller":"traceutil/trace.go:171","msg":"trace[1195226763] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"102.103642ms","start":"2026-09-23T10:29:37.6238Z","end":"2026-09-23T10:29:37.725904Z","steps":["trace[1195226763] 'process raft request' (duration: 92.27537ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:29:38.598937Z","caller":"traceutil/trace.go:171","msg":"trace[1272027526] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"159.262968ms","start":"2026-09-23T10:29:38.43965Z","end":"2026-09-23T10:29:38.598913Z","steps":["trace[1272027526] 'process raft request' (duration: 159.129284ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:30:02.928397Z","caller":"traceutil/trace.go:171","msg":"trace[1983326970] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"141.65747ms","start":"2026-09-23T10:30:02.78671Z","end":"2026-09-23T10:30:02.928367Z","steps":["trace[1983326970] 'process raft request' (duration: 123.511171ms)","trace[1983326970] 'compare' (duration: 17.880271ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:30:08.656403Z","caller":"traceutil/trace.go:171","msg":"trace[1519564834] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1565; }","duration":"105.468835ms","start":"2026-09-23T10:30:08.550907Z","end":"2026-09-23T10:30:08.656375Z","steps":["trace[1519564834] 'process raft request' (duration: 105.327641ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:30:27.202052Z","caller":"traceutil/trace.go:171","msg":"trace[1283780578] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1939; }","duration":"287.951098ms","start":"2026-09-23T10:30:26.914077Z","end":"2026-09-23T10:30:27.202028Z","steps":["trace[1283780578] 'read index received' (duration: 287.752482ms)","trace[1283780578] 'applied index is now lower than readState.Index' (duration: 197.776µs)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:30:27.20212Z","caller":"traceutil/trace.go:171","msg":"trace[87102217] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"371.789743ms","start":"2026-09-23T10:30:26.830284Z","end":"2026-09-23T10:30:27.202073Z","steps":["trace[87102217] 'process raft request' (duration: 371.601888ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:30:27.202234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.109222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:30:27.202309Z","caller":"traceutil/trace.go:171","msg":"trace[230856687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1868; }","duration":"288.257516ms","start":"2026-09-23T10:30:26.914034Z","end":"2026-09-23T10:30:27.202291Z","steps":["trace[230856687] 'agreement among raft nodes before linearized reading' (duration: 288.091652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:30:27.20239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:30:26.830259Z","time spent":"371.911817ms","remote":"127.0.0.1:48342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-23T10:30:27.202354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.474834ms","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-09-23T10:30:27.202644Z","caller":"traceutil/trace.go:171","msg":"trace[828826146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1868; }","duration":"153.800584ms","start":"2026-09-23T10:30:27.048831Z","end":"2026-09-23T10:30:27.202632Z","steps":["trace[828826146] 'agreement among raft nodes before linearized reading' (duration: 153.351651ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:31:01.187423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.95326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-23T10:31:01.18761Z","caller":"traceutil/trace.go:171","msg":"trace[848404456] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2110; }","duration":"183.215547ms","start":"2026-09-23T10:31:01.004358Z","end":"2026-09-23T10:31:01.187573Z","steps":["trace[848404456] 'range keys from in-memory index tree' (duration: 182.635482ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:31:02.026397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.871073ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-23T10:31:02.026489Z","caller":"traceutil/trace.go:171","msg":"trace[1855084823] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2194; }","duration":"296.227641ms","start":"2026-09-23T10:31:01.730244Z","end":"2026-09-23T10:31:02.026472Z","steps":["trace[1855084823] 'read index received' (duration: 35.071µs)","trace[1855084823] 'applied index is now lower than readState.Index' (duration: 296.1913ms)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:31:02.026601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.351814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-23T10:31:02.026624Z","caller":"traceutil/trace.go:171","msg":"trace[1766460329] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2115; }","duration":"296.409856ms","start":"2026-09-23T10:31:01.730205Z","end":"2026-09-23T10:31:02.026615Z","steps":["trace[1766460329] 'agreement among raft nodes before linearized reading' (duration: 296.324214ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:31:02.026685Z","caller":"traceutil/trace.go:171","msg":"trace[487277290] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"414.734826ms","start":"2026-09-23T10:31:01.611907Z","end":"2026-09-23T10:31:02.026642Z","steps":["trace[487277290] 'process raft request' (duration: 102.548774ms)","trace[487277290] 'compare' (duration: 311.496094ms)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:31:02.026878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:31:01.611875Z","time spent":"414.89994ms","remote":"127.0.0.1:48242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-23T10:31:02.248982Z","caller":"traceutil/trace.go:171","msg":"trace[1735986365] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2195; }","duration":"149.174146ms","start":"2026-09-23T10:31:02.099735Z","end":"2026-09-23T10:31:02.248909Z","steps":["trace[1735986365] 'read index received' (duration: 123.114256ms)","trace[1735986365] 'applied index is now lower than readState.Index' (duration: 26.05779ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:31:02.249069Z","caller":"traceutil/trace.go:171","msg":"trace[874826489] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"181.594269ms","start":"2026-09-23T10:31:02.067425Z","end":"2026-09-23T10:31:02.249019Z","steps":["trace[874826489] 'process raft request' (duration: 155.530669ms)","trace[874826489] 'compare' (duration: 25.490876ms)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:31:02.249363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.599546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-23T10:31:02.249418Z","caller":"traceutil/trace.go:171","msg":"trace[196118358] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2116; }","duration":"149.727139ms","start":"2026-09-23T10:31:02.099677Z","end":"2026-09-23T10:31:02.249404Z","steps":["trace[196118358] 'agreement among raft nodes before linearized reading' (duration: 149.443272ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:32:08.060948Z","caller":"traceutil/trace.go:171","msg":"trace[1272367209] transaction","detail":"{read_only:false; response_revision:2575; number_of_response:1; }","duration":"175.483577ms","start":"2026-09-23T10:32:07.885453Z","end":"2026-09-23T10:32:08.060937Z","steps":["trace[1272367209] 'process raft request' (duration: 175.367304ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:32:08.060999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.577753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:32:08.061021Z","caller":"traceutil/trace.go:171","msg":"trace[105242148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2575; }","duration":"147.637914ms","start":"2026-09-23T10:32:07.913377Z","end":"2026-09-23T10:32:08.061015Z","steps":["trace[105242148] 'agreement among raft nodes before linearized reading' (duration: 147.590313ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:32:08.060931Z","caller":"traceutil/trace.go:171","msg":"trace[700769295] linearizableReadLoop","detail":"{readStateIndex:2671; appliedIndex:2670; }","duration":"147.507071ms","start":"2026-09-23T10:32:07.91341Z","end":"2026-09-23T10:32:08.060917Z","steps":["trace[700769295] 'read index received' (duration: 147.392908ms)","trace[700769295] 'applied index is now lower than readState.Index' (duration: 113.473µs)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:32:08.061126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.853854ms","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-09-23T10:32:08.061151Z","caller":"traceutil/trace.go:171","msg":"trace[1314493089] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2575; }","duration":"106.906476ms","start":"2026-09-23T10:32:07.954237Z","end":"2026-09-23T10:32:08.061144Z","steps":["trace[1314493089] 'agreement among raft nodes before linearized reading' (duration: 106.820284ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:32:39.208306Z","caller":"traceutil/trace.go:171","msg":"trace[1140074212] linearizableReadLoop","detail":"{readStateIndex:2850; appliedIndex:2849; }","duration":"173.273396ms","start":"2026-09-23T10:32:39.035Z","end":"2026-09-23T10:32:39.208273Z","steps":["trace[1140074212] 'read index received' (duration: 173.072191ms)","trace[1140074212] 'applied index is now lower than readState.Index' (duration: 200.605µs)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:32:39.208355Z","caller":"traceutil/trace.go:171","msg":"trace[1199094115] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"198.027566ms","start":"2026-09-23T10:32:39.010309Z","end":"2026-09-23T10:32:39.208336Z","steps":["trace[1199094115] 'process raft request' (duration: 197.787859ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:32:39.20877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.743439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-23T10:32:39.208867Z","caller":"traceutil/trace.go:171","msg":"trace[582167905] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2747; }","duration":"173.882503ms","start":"2026-09-23T10:32:39.034963Z","end":"2026-09-23T10:32:39.208846Z","steps":["trace[582167905] 'agreement among raft nodes before linearized reading' (duration: 173.40421ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:36:23.845358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.208353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-23T10:36:23.845609Z","caller":"traceutil/trace.go:171","msg":"trace[1949503139] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:4050; }","duration":"102.508681ms","start":"2026-09-23T10:36:23.743044Z","end":"2026-09-23T10:36:23.845553Z","steps":["trace[1949503139] 'agreement among raft nodes before linearized reading' (duration: 102.12262ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:10.980811Z","caller":"traceutil/trace.go:171","msg":"trace[1748767074] linearizableReadLoop","detail":"{readStateIndex:4984; appliedIndex:4982; }","duration":"234.550644ms","start":"2026-09-23T10:37:10.746237Z","end":"2026-09-23T10:37:10.980787Z","steps":["trace[1748767074] 'read index received' (duration: 45.341902ms)","trace[1748767074] 'applied index is now lower than readState.Index' (duration: 189.207982ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:37:10.980897Z","caller":"traceutil/trace.go:171","msg":"trace[1794455790] transaction","detail":"{read_only:false; response_revision:4802; number_of_response:1; }","duration":"234.976616ms","start":"2026-09-23T10:37:10.745891Z","end":"2026-09-23T10:37:10.980867Z","steps":["trace[1794455790] 'process raft request' (duration: 234.76836ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:10.981111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.851893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-23T10:37:10.981152Z","caller":"traceutil/trace.go:171","msg":"trace[871005514] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4802; }","duration":"234.922785ms","start":"2026-09-23T10:37:10.746217Z","end":"2026-09-23T10:37:10.981139Z","steps":["trace[871005514] 'agreement among raft nodes before linearized reading' (duration: 234.76062ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:11.057759Z","caller":"traceutil/trace.go:171","msg":"trace[15810686] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"251.84105ms","start":"2026-09-23T10:37:10.805883Z","end":"2026-09-23T10:37:11.057724Z","steps":["trace[15810686] 'process raft request' (duration: 251.506171ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:11.058088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.950496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/grafana-tls\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-23T10:37:11.05815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.013343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-23T10:37:11.058172Z","caller":"traceutil/trace.go:171","msg":"trace[369282499] range","detail":"{range_begin:/registry/secrets/monitoring/grafana-tls; range_end:; response_count:0; response_revision:4805; }","duration":"302.094841ms","start":"2026-09-23T10:37:10.756057Z","end":"2026-09-23T10:37:11.058152Z","steps":["trace[369282499] 'agreement among raft nodes before linearized reading' (duration: 301.922976ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:11.058218Z","caller":"traceutil/trace.go:171","msg":"trace[711255117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4805; }","duration":"144.127006ms","start":"2026-09-23T10:37:10.914073Z","end":"2026-09-23T10:37:11.0582Z","steps":["trace[711255117] 'agreement among raft nodes before linearized reading' (duration: 144.002473ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:11.058226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:37:10.756044Z","time spent":"302.172593ms","remote":"127.0.0.1:48250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/monitoring/grafana-tls\" "} {"level":"warn","ts":"2026-09-23T10:37:11.05832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.256698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4c62f085-8d3c-4d25-8f16-f41168800165\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-09-23T10:37:11.057897Z","caller":"traceutil/trace.go:171","msg":"trace[277127069] transaction","detail":"{read_only:false; response_revision:4805; number_of_response:1; }","duration":"152.164012ms","start":"2026-09-23T10:37:10.905709Z","end":"2026-09-23T10:37:11.057873Z","steps":["trace[277127069] 'process raft request' (duration: 152.044779ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:11.057948Z","caller":"traceutil/trace.go:171","msg":"trace[1380540531] transaction","detail":"{read_only:false; response_revision:4804; number_of_response:1; }","duration":"193.690178ms","start":"2026-09-23T10:37:10.864242Z","end":"2026-09-23T10:37:11.057932Z","steps":["trace[1380540531] 'process raft request' (duration: 193.392199ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:11.058419Z","caller":"traceutil/trace.go:171","msg":"trace[1877670729] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4c62f085-8d3c-4d25-8f16-f41168800165; range_end:; response_count:1; response_revision:4805; }","duration":"119.486405ms","start":"2026-09-23T10:37:10.93891Z","end":"2026-09-23T10:37:11.058397Z","steps":["trace[1877670729] 'agreement among raft nodes before linearized reading' (duration: 118.998871ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:23.979037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.897264ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-23T10:37:23.979248Z","caller":"traceutil/trace.go:171","msg":"trace[863860520] transaction","detail":"{read_only:false; response_revision:5056; number_of_response:1; }","duration":"226.068279ms","start":"2026-09-23T10:37:23.753166Z","end":"2026-09-23T10:37:23.979235Z","steps":["trace[863860520] 'process raft request' (duration: 225.964126ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:23.979239Z","caller":"traceutil/trace.go:171","msg":"trace[1965479100] linearizableReadLoop","detail":"{readStateIndex:5246; appliedIndex:5245; }","duration":"329.509974ms","start":"2026-09-23T10:37:23.649705Z","end":"2026-09-23T10:37:23.979215Z","steps":["trace[1965479100] 'read index received' (duration: 186.526629ms)","trace[1965479100] 'applied index is now lower than readState.Index' (duration: 142.982325ms)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:37:23.979407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.69772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-23T10:37:23.979431Z","caller":"traceutil/trace.go:171","msg":"trace[632439443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5056; }","duration":"329.767942ms","start":"2026-09-23T10:37:23.649656Z","end":"2026-09-23T10:37:23.979424Z","steps":["trace[632439443] 'agreement among raft nodes before linearized reading' (duration: 329.650969ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:23.979431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.33019ms","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-09-23T10:37:23.979475Z","caller":"traceutil/trace.go:171","msg":"trace[1693466724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5056; }","duration":"172.451123ms","start":"2026-09-23T10:37:23.806999Z","end":"2026-09-23T10:37:23.97945Z","steps":["trace[1693466724] 'agreement among raft nodes before linearized reading' (duration: 172.35083ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:23.97945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-23T10:37:23.649635Z","time spent":"329.810153ms","remote":"127.0.0.1:48422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-23T10:37:23.979609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.427843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-657c77d8bf-v96zz.18d7ece474a2b46a\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-09-23T10:37:23.979629Z","caller":"traceutil/trace.go:171","msg":"trace[88756170] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-657c77d8bf-v96zz.18d7ece474a2b46a; range_end:; response_count:1; response_revision:5056; }","duration":"104.477775ms","start":"2026-09-23T10:37:23.875144Z","end":"2026-09-23T10:37:23.979621Z","steps":["trace[88756170] 'agreement among raft nodes before linearized reading' (duration: 104.417123ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:23.979778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.615548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12973"} {"level":"info","ts":"2026-09-23T10:37:23.979796Z","caller":"traceutil/trace.go:171","msg":"trace[1018227927] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5056; }","duration":"104.67107ms","start":"2026-09-23T10:37:23.875119Z","end":"2026-09-23T10:37:23.97979Z","steps":["trace[1018227927] 'agreement among raft nodes before linearized reading' (duration: 104.612408ms)"],"step_count":1} {"level":"warn","ts":"2026-09-23T10:37:24.510908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.889732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-23T10:37:24.511098Z","caller":"traceutil/trace.go:171","msg":"trace[1241359356] transaction","detail":"{read_only:false; response_revision:5067; number_of_response:1; }","duration":"122.927753ms","start":"2026-09-23T10:37:24.38815Z","end":"2026-09-23T10:37:24.511078Z","steps":["trace[1241359356] 'process raft request' (duration: 122.855691ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:24.511154Z","caller":"traceutil/trace.go:171","msg":"trace[1693964011] transaction","detail":"{read_only:false; response_revision:5066; number_of_response:1; }","duration":"133.815098ms","start":"2026-09-23T10:37:24.377274Z","end":"2026-09-23T10:37:24.511089Z","steps":["trace[1693964011] 'process raft request' (duration: 31.643728ms)","trace[1693964011] 'compare' (duration: 101.749408ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:37:24.511222Z","caller":"traceutil/trace.go:171","msg":"trace[1881517151] linearizableReadLoop","detail":"{readStateIndex:5257; appliedIndex:5256; }","duration":"132.08278ms","start":"2026-09-23T10:37:24.379099Z","end":"2026-09-23T10:37:24.511182Z","steps":["trace[1881517151] 'read index received' (duration: 29.837138ms)","trace[1881517151] 'applied index is now lower than readState.Index' (duration: 102.242062ms)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:37:24.511523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.356347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-09-23T10:37:24.51168Z","caller":"traceutil/trace.go:171","msg":"trace[502980378] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5067; }","duration":"132.535972ms","start":"2026-09-23T10:37:24.379057Z","end":"2026-09-23T10:37:24.511593Z","steps":["trace[502980378] 'agreement among raft nodes before linearized reading' (duration: 132.253904ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:24.512534Z","caller":"traceutil/trace.go:171","msg":"trace[1442651500] transaction","detail":"{read_only:false; response_revision:5068; number_of_response:1; }","duration":"102.082407ms","start":"2026-09-23T10:37:24.41044Z","end":"2026-09-23T10:37:24.512522Z","steps":["trace[1442651500] 'process raft request' (duration: 101.964114ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:36.114223Z","caller":"traceutil/trace.go:171","msg":"trace[495828446] transaction","detail":"{read_only:false; response_revision:5208; number_of_response:1; }","duration":"136.596608ms","start":"2026-09-23T10:37:35.977594Z","end":"2026-09-23T10:37:36.114191Z","steps":["trace[495828446] 'process raft request' (duration: 136.365381ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:36.269591Z","caller":"traceutil/trace.go:171","msg":"trace[1926208458] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"147.374601ms","start":"2026-09-23T10:37:36.122199Z","end":"2026-09-23T10:37:36.269574Z","steps":["trace[1926208458] 'process raft request' (duration: 147.3434ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:36.26965Z","caller":"traceutil/trace.go:171","msg":"trace[324720338] transaction","detail":"{read_only:false; response_revision:5211; number_of_response:1; }","duration":"147.507834ms","start":"2026-09-23T10:37:36.12212Z","end":"2026-09-23T10:37:36.269628Z","steps":["trace[324720338] 'process raft request' (duration: 147.307619ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:36.26976Z","caller":"traceutil/trace.go:171","msg":"trace[691028595] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"147.602447ms","start":"2026-09-23T10:37:36.12212Z","end":"2026-09-23T10:37:36.269722Z","steps":["trace[691028595] 'process raft request' (duration: 147.3426ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:36.269792Z","caller":"traceutil/trace.go:171","msg":"trace[363269719] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"147.579706ms","start":"2026-09-23T10:37:36.122201Z","end":"2026-09-23T10:37:36.269781Z","steps":["trace[363269719] 'process raft request' (duration: 147.319619ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:36.26987Z","caller":"traceutil/trace.go:171","msg":"trace[1672169833] transaction","detail":"{read_only:false; response_revision:5210; number_of_response:1; }","duration":"175.265234ms","start":"2026-09-23T10:37:36.09458Z","end":"2026-09-23T10:37:36.269845Z","steps":["trace[1672169833] 'process raft request' (duration: 174.807701ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:36.269915Z","caller":"traceutil/trace.go:171","msg":"trace[1265481253] linearizableReadLoop","detail":"{readStateIndex:5406; appliedIndex:5404; }","duration":"152.375111ms","start":"2026-09-23T10:37:36.117506Z","end":"2026-09-23T10:37:36.269881Z","steps":["trace[1265481253] 'read index received' (duration: 105.521395ms)","trace[1265481253] 'applied index is now lower than readState.Index' (duration: 46.851316ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:37:36.269971Z","caller":"traceutil/trace.go:171","msg":"trace[155404533] transaction","detail":"{read_only:false; response_revision:5209; number_of_response:1; }","duration":"244.766868ms","start":"2026-09-23T10:37:36.025192Z","end":"2026-09-23T10:37:36.269959Z","steps":["trace[155404533] 'process raft request' (duration: 197.822878ms)","trace[155404533] 'compare' (duration: 46.273241ms)"],"step_count":2} {"level":"warn","ts":"2026-09-23T10:37:36.270234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.6852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-89943347-9fdd-45be-9152-0f88bca16c92\" ","response":"range_response_count:1 size:1322"} {"level":"warn","ts":"2026-09-23T10:37:36.270245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.526316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-23T10:37:36.270247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.013969ms","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-09-23T10:37:36.270277Z","caller":"traceutil/trace.go:171","msg":"trace[1433439739] range","detail":"{range_begin:/registry/persistentvolumes/pvc-89943347-9fdd-45be-9152-0f88bca16c92; range_end:; response_count:1; response_revision:5214; }","duration":"152.827064ms","start":"2026-09-23T10:37:36.117438Z","end":"2026-09-23T10:37:36.270265Z","steps":["trace[1433439739] 'agreement among raft nodes before linearized reading' (duration: 152.619548ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:36.270281Z","caller":"traceutil/trace.go:171","msg":"trace[2076782725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5214; }","duration":"152.599938ms","start":"2026-09-23T10:37:36.117669Z","end":"2026-09-23T10:37:36.270269Z","steps":["trace[2076782725] 'agreement among raft nodes before linearized reading' (duration: 152.431013ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:36.270296Z","caller":"traceutil/trace.go:171","msg":"trace[1033593807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5214; }","duration":"148.110992ms","start":"2026-09-23T10:37:36.122171Z","end":"2026-09-23T10:37:36.270282Z","steps":["trace[1033593807] 'agreement among raft nodes before linearized reading' (duration: 147.939347ms)"],"step_count":1} {"level":"info","ts":"2026-09-23T10:37:55.627909Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2833} {"level":"info","ts":"2026-09-23T10:37:55.715456Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2833,"took":"86.243905ms","hash":515921929,"current-db-size-bytes":52613120,"current-db-size":"53 MB","current-db-size-in-use-bytes":27570176,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-23T10:37:55.715681Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":515921929,"revision":2833,"compact-revision":-1} {"level":"info","ts":"2026-09-23T10:41:16.694852Z","caller":"traceutil/trace.go:171","msg":"trace[2126159735] transaction","detail":"{read_only:false; response_revision:6841; number_of_response:1; }","duration":"121.163293ms","start":"2026-09-23T10:41:16.573662Z","end":"2026-09-23T10:41:16.694826Z","steps":["trace[2126159735] 'process raft request' (duration: 22.109547ms)","trace[2126159735] 'compare' (duration: 98.926122ms)"],"step_count":2} {"level":"info","ts":"2026-09-23T10:42:55.636462Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5365} {"level":"info","ts":"2026-09-23T10:42:55.721814Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5365,"took":"83.908994ms","hash":3356496718,"current-db-size-bytes":52613120,"current-db-size":"53 MB","current-db-size-in-use-bytes":18812928,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-23T10:42:55.721908Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3356496718,"revision":5365,"compact-revision":2833}