{"level":"warn","ts":"2026-09-06T09:38:18.617638Z","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-06T09:38:18.617793Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.138: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.138:2380","--initial-cluster=instance=https://162.253.55.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.138: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-06T09:38:18.617918Z","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-06T09:38:18.617939Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.138:2380"]} {"level":"info","ts":"2026-09-06T09:38:18.61797Z","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-06T09:38:18.619067Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.138:2379"]} {"level":"info","ts":"2026-09-06T09:38:18.619189Z","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.138:2380"],"listen-peer-urls":["https://162.253.55.138:2380"],"advertise-client-urls":["https://162.253.55.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.138: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-06T09:38:18.625685Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.085804ms"} {"level":"info","ts":"2026-09-06T09:38:18.639584Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ee8e5a779fc25cea","cluster-id":"8f8e3b77da0cbcef"} {"level":"info","ts":"2026-09-06T09:38:18.639711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea switched to configuration voters=()"} {"level":"info","ts":"2026-09-06T09:38:18.639735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea became follower at term 0"} {"level":"info","ts":"2026-09-06T09:38:18.639745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ee8e5a779fc25cea [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-06T09:38:18.639757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea became follower at term 1"} {"level":"info","ts":"2026-09-06T09:38:18.639799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea switched to configuration voters=(17189776297547685098)"} {"level":"warn","ts":"2026-09-06T09:38:18.649329Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-06T09:38:18.652019Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-06T09:38:18.655854Z","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-06T09:38:18.659088Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ee8e5a779fc25cea","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-06T09:38:18.659453Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ee8e5a779fc25cea","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-06T09:38:18.659622Z","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-06T09:38:18.659728Z","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-06T09:38:18.659774Z","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-06T09:38:18.661469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea switched to configuration voters=(17189776297547685098)"} {"level":"info","ts":"2026-09-06T09:38:18.663798Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8f8e3b77da0cbcef","local-member-id":"ee8e5a779fc25cea","added-peer-id":"ee8e5a779fc25cea","added-peer-peer-urls":["https://162.253.55.138:2380"]} {"level":"info","ts":"2026-09-06T09:38:18.664685Z","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-06T09:38:18.664915Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ee8e5a779fc25cea","initial-advertise-peer-urls":["https://162.253.55.138:2380"],"listen-peer-urls":["https://162.253.55.138:2380"],"advertise-client-urls":["https://162.253.55.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-06T09:38:18.664942Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-06T09:38:18.665516Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.138:2380"} {"level":"info","ts":"2026-09-06T09:38:18.66554Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.138:2380"} {"level":"info","ts":"2026-09-06T09:38:18.940803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea is starting a new election at term 1"} {"level":"info","ts":"2026-09-06T09:38:18.940888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea became pre-candidate at term 1"} {"level":"info","ts":"2026-09-06T09:38:18.940919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea received MsgPreVoteResp from ee8e5a779fc25cea at term 1"} {"level":"info","ts":"2026-09-06T09:38:18.940944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea became candidate at term 2"} {"level":"info","ts":"2026-09-06T09:38:18.940958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea received MsgVoteResp from ee8e5a779fc25cea at term 2"} {"level":"info","ts":"2026-09-06T09:38:18.940984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea became leader at term 2"} {"level":"info","ts":"2026-09-06T09:38:18.941004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ee8e5a779fc25cea elected leader ee8e5a779fc25cea at term 2"} {"level":"info","ts":"2026-09-06T09:38:18.942267Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ee8e5a779fc25cea","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.138:2379]}","request-path":"/0/members/ee8e5a779fc25cea/attributes","cluster-id":"8f8e3b77da0cbcef","publish-timeout":"7s"} {"level":"info","ts":"2026-09-06T09:38:18.942338Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-06T09:38:18.942451Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-06T09:38:18.942508Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-06T09:38:18.942622Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-06T09:38:18.942692Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-06T09:38:18.944906Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8f8e3b77da0cbcef","local-member-id":"ee8e5a779fc25cea","cluster-version":"3.5"} {"level":"info","ts":"2026-09-06T09:38:18.945011Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-06T09:38:18.945064Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-06T09:38:18.946435Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.138:2379"} {"level":"info","ts":"2026-09-06T09:38:18.949974Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-06T09:38:32.618087Z","caller":"traceutil/trace.go:171","msg":"trace[543830217] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"113.499902ms","start":"2026-09-06T09:38:32.504567Z","end":"2026-09-06T09:38:32.618067Z","steps":["trace[543830217] 'process raft request' (duration: 113.368057ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:38:33.200238Z","caller":"traceutil/trace.go:171","msg":"trace[1270222056] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"186.92068ms","start":"2026-09-06T09:38:33.01329Z","end":"2026-09-06T09:38:33.200211Z","steps":["trace[1270222056] 'process raft request' (duration: 186.705572ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.612004Z","caller":"traceutil/trace.go:171","msg":"trace[757911062] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"154.594537ms","start":"2026-09-06T09:39:25.457385Z","end":"2026-09-06T09:39:25.61198Z","steps":["trace[757911062] 'process raft request' (duration: 154.42914ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.619573Z","caller":"traceutil/trace.go:171","msg":"trace[423622895] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"157.251388ms","start":"2026-09-06T09:39:25.462246Z","end":"2026-09-06T09:39:25.619497Z","steps":["trace[423622895] 'process raft request' (duration: 156.877161ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.619559Z","caller":"traceutil/trace.go:171","msg":"trace[1254991560] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"157.235078ms","start":"2026-09-06T09:39:25.46229Z","end":"2026-09-06T09:39:25.619525Z","steps":["trace[1254991560] 'process raft request' (duration: 156.988646ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.619777Z","caller":"traceutil/trace.go:171","msg":"trace[995351209] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"149.834359ms","start":"2026-09-06T09:39:25.469906Z","end":"2026-09-06T09:39:25.61974Z","steps":["trace[995351209] 'process raft request' (duration: 149.481313ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.620587Z","caller":"traceutil/trace.go:171","msg":"trace[376773168] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:615; }","duration":"116.766635ms","start":"2026-09-06T09:39:25.503793Z","end":"2026-09-06T09:39:25.620559Z","steps":["trace[376773168] 'read index received' (duration: 108.041606ms)","trace[376773168] 'applied index is now lower than readState.Index' (duration: 8.723939ms)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:39:25.620801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.977535ms","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-09-06T09:39:25.620927Z","caller":"traceutil/trace.go:171","msg":"trace[776650826] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"145.560834ms","start":"2026-09-06T09:39:25.475344Z","end":"2026-09-06T09:39:25.620905Z","steps":["trace[776650826] 'process raft request' (duration: 144.853991ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.621081Z","caller":"traceutil/trace.go:171","msg":"trace[1899009408] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"151.045194ms","start":"2026-09-06T09:39:25.470026Z","end":"2026-09-06T09:39:25.621071Z","steps":["trace[1899009408] 'process raft request' (duration: 149.950864ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.621232Z","caller":"traceutil/trace.go:171","msg":"trace[2001562525] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"151.128028ms","start":"2026-09-06T09:39:25.470095Z","end":"2026-09-06T09:39:25.621223Z","steps":["trace[2001562525] 'process raft request' (duration: 149.964775ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.621368Z","caller":"traceutil/trace.go:171","msg":"trace[564526645] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"147.501482ms","start":"2026-09-06T09:39:25.473857Z","end":"2026-09-06T09:39:25.621359Z","steps":["trace[564526645] 'process raft request' (duration: 146.249225ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.621505Z","caller":"traceutil/trace.go:171","msg":"trace[981722173] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"109.554676ms","start":"2026-09-06T09:39:25.511939Z","end":"2026-09-06T09:39:25.621494Z","steps":["trace[981722173] 'process raft request' (duration: 108.431244ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.621638Z","caller":"traceutil/trace.go:171","msg":"trace[141568444] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"114.055181ms","start":"2026-09-06T09:39:25.507574Z","end":"2026-09-06T09:39:25.621629Z","steps":["trace[141568444] 'process raft request' (duration: 112.699619ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:25.620891Z","caller":"traceutil/trace.go:171","msg":"trace[1339800632] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"117.115291ms","start":"2026-09-06T09:39:25.503758Z","end":"2026-09-06T09:39:25.620873Z","steps":["trace[1339800632] 'agreement among raft nodes before linearized reading' (duration: 116.887201ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:26.451803Z","caller":"traceutil/trace.go:171","msg":"trace[802976242] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"343.94558ms","start":"2026-09-06T09:39:26.107838Z","end":"2026-09-06T09:39:26.451783Z","steps":["trace[802976242] 'process raft request' (duration: 343.753221ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:39:26.45219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-06T09:39:26.107819Z","time spent":"344.044245ms","remote":"127.0.0.1:35304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-06T09:39:26.486223Z","caller":"traceutil/trace.go:171","msg":"trace[142160962] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"279.100127ms","start":"2026-09-06T09:39:26.207106Z","end":"2026-09-06T09:39:26.486206Z","steps":["trace[142160962] 'read index received' (duration: 245.207254ms)","trace[142160962] 'applied index is now lower than readState.Index' (duration: 33.892273ms)"],"step_count":2} {"level":"info","ts":"2026-09-06T09:39:26.486304Z","caller":"traceutil/trace.go:171","msg":"trace[1286640798] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"234.720032ms","start":"2026-09-06T09:39:26.251571Z","end":"2026-09-06T09:39:26.486291Z","steps":["trace[1286640798] 'process raft request' (duration: 234.485812ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:39:26.486531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.403761ms","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-06T09:39:26.486618Z","caller":"traceutil/trace.go:171","msg":"trace[36143651] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:652; }","duration":"279.516746ms","start":"2026-09-06T09:39:26.207079Z","end":"2026-09-06T09:39:26.486596Z","steps":["trace[36143651] 'agreement among raft nodes before linearized reading' (duration: 279.331498ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:26.486555Z","caller":"traceutil/trace.go:171","msg":"trace[1515318196] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"354.62326ms","start":"2026-09-06T09:39:26.131602Z","end":"2026-09-06T09:39:26.486225Z","steps":["trace[1515318196] 'process raft request' (duration: 354.274854ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:39:26.487037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-06T09:39:26.131583Z","time spent":"355.29999ms","remote":"127.0.0.1:35304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-06T09:39:31.894526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.294272ms","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-09-06T09:39:31.894626Z","caller":"traceutil/trace.go:171","msg":"trace[1381665658] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:696; }","duration":"227.434269ms","start":"2026-09-06T09:39:31.667168Z","end":"2026-09-06T09:39:31.894602Z","steps":["trace[1381665658] 'range keys from in-memory index tree' (duration: 227.020099ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:32.020012Z","caller":"traceutil/trace.go:171","msg":"trace[326535491] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"121.373789ms","start":"2026-09-06T09:39:31.898622Z","end":"2026-09-06T09:39:32.019996Z","steps":["trace[326535491] 'process raft request' (duration: 121.223842ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:32.705383Z","caller":"traceutil/trace.go:171","msg":"trace[817475409] linearizableReadLoop","detail":"{readStateIndex:729; appliedIndex:728; }","duration":"346.364528ms","start":"2026-09-06T09:39:32.358991Z","end":"2026-09-06T09:39:32.705355Z","steps":["trace[817475409] 'read index received' (duration: 250.779145ms)","trace[817475409] 'applied index is now lower than readState.Index' (duration: 95.584303ms)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:39:32.705728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.556018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-06T09:39:32.705771Z","caller":"traceutil/trace.go:171","msg":"trace[787336360] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"667.088928ms","start":"2026-09-06T09:39:32.038515Z","end":"2026-09-06T09:39:32.705604Z","steps":["trace[787336360] 'process raft request' (duration: 571.419941ms)","trace[787336360] 'compare' (duration: 94.905342ms)"],"step_count":2} {"level":"info","ts":"2026-09-06T09:39:32.705794Z","caller":"traceutil/trace.go:171","msg":"trace[1887260121] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:699; }","duration":"222.680144ms","start":"2026-09-06T09:39:32.483098Z","end":"2026-09-06T09:39:32.705778Z","steps":["trace[1887260121] 'agreement among raft nodes before linearized reading' (duration: 222.545828ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:39:32.705926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.917873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.138\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-09-06T09:39:32.705956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-06T09:39:32.038492Z","time spent":"667.35464ms","remote":"127.0.0.1:35350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-06T09:39:32.706125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.309437ms","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-06T09:39:32.706276Z","caller":"traceutil/trace.go:171","msg":"trace[1527068208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:699; }","duration":"179.516977ms","start":"2026-09-06T09:39:32.526748Z","end":"2026-09-06T09:39:32.706265Z","steps":["trace[1527068208] 'agreement among raft nodes before linearized reading' (duration: 178.952131ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:39:32.70614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.758198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-06T09:39:32.706463Z","caller":"traceutil/trace.go:171","msg":"trace[439209730] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:699; }","duration":"191.061841ms","start":"2026-09-06T09:39:32.515368Z","end":"2026-09-06T09:39:32.70643Z","steps":["trace[439209730] 'agreement among raft nodes before linearized reading' (duration: 190.657843ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:39:32.706195Z","caller":"traceutil/trace.go:171","msg":"trace[2054944884] range","detail":"{range_begin:/registry/masterleases/162.253.55.138; range_end:; response_count:1; response_revision:699; }","duration":"347.07257ms","start":"2026-09-06T09:39:32.358942Z","end":"2026-09-06T09:39:32.706014Z","steps":["trace[2054944884] 'agreement among raft nodes before linearized reading' (duration: 346.897262ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:39:32.706648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-06T09:39:32.358922Z","time spent":"347.661178ms","remote":"127.0.0.1:35286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.138\" "} {"level":"info","ts":"2026-09-06T09:39:51.197725Z","caller":"traceutil/trace.go:171","msg":"trace[1324587193] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"172.774745ms","start":"2026-09-06T09:39:51.024909Z","end":"2026-09-06T09:39:51.197683Z","steps":["trace[1324587193] 'process raft request' (duration: 172.637718ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:40:22.207105Z","caller":"traceutil/trace.go:171","msg":"trace[647600054] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"219.818761ms","start":"2026-09-06T09:40:21.987259Z","end":"2026-09-06T09:40:22.207078Z","steps":["trace[647600054] 'process raft request' (duration: 219.655863ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:41:12.852201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.52365ms","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-09-06T09:41:12.852289Z","caller":"traceutil/trace.go:171","msg":"trace[160261640] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1967; }","duration":"302.65328ms","start":"2026-09-06T09:41:12.549617Z","end":"2026-09-06T09:41:12.852271Z","steps":["trace[160261640] 'range keys from in-memory index tree' (duration: 302.338012ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:41:12.852324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-06T09:41:12.549597Z","time spent":"302.7193ms","remote":"127.0.0.1:35530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-06T09:41:12.852202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.923669ms","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-06T09:41:12.852497Z","caller":"traceutil/trace.go:171","msg":"trace[956190027] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1967; }","duration":"140.264897ms","start":"2026-09-06T09:41:12.712216Z","end":"2026-09-06T09:41:12.85248Z","steps":["trace[956190027] 'range keys from in-memory index tree' (duration: 139.81258ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:13.389013Z","caller":"traceutil/trace.go:171","msg":"trace[607778554] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"300.230367ms","start":"2026-09-06T09:41:13.088751Z","end":"2026-09-06T09:41:13.388982Z","steps":["trace[607778554] 'process raft request' (duration: 299.952578ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:41:13.389215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-06T09:41:13.088729Z","time spent":"300.374216ms","remote":"127.0.0.1:35330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":967,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-06T09:41:13.389474Z","caller":"traceutil/trace.go:171","msg":"trace[1833098090] linearizableReadLoop","detail":"{readStateIndex:2049; appliedIndex:2048; }","duration":"285.920599ms","start":"2026-09-06T09:41:13.102976Z","end":"2026-09-06T09:41:13.388897Z","steps":["trace[1833098090] 'read index received' (duration: 285.67395ms)","trace[1833098090] 'applied index is now lower than readState.Index' (duration: 245.559µs)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:41:13.38955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.487426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-487b35a6-1a99-4933-a11c-7db061915b96\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-06T09:41:13.389975Z","caller":"traceutil/trace.go:171","msg":"trace[878128531] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-487b35a6-1a99-4933-a11c-7db061915b96; range_end:; response_count:1; response_revision:1971; }","duration":"287.032743ms","start":"2026-09-06T09:41:13.102914Z","end":"2026-09-06T09:41:13.389946Z","steps":["trace[878128531] 'agreement among raft nodes before linearized reading' (duration: 286.223067ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:13.412255Z","caller":"traceutil/trace.go:171","msg":"trace[498177008] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"178.821193ms","start":"2026-09-06T09:41:13.233418Z","end":"2026-09-06T09:41:13.41224Z","steps":["trace[498177008] 'process raft request' (duration: 178.691134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:41:13.412605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.527915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-06T09:41:13.412655Z","caller":"traceutil/trace.go:171","msg":"trace[460047926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1973; }","duration":"118.658305ms","start":"2026-09-06T09:41:13.293985Z","end":"2026-09-06T09:41:13.412643Z","steps":["trace[460047926] 'agreement among raft nodes before linearized reading' (duration: 118.517015ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:24.746253Z","caller":"traceutil/trace.go:171","msg":"trace[1647531623] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"241.130521ms","start":"2026-09-06T09:41:24.505085Z","end":"2026-09-06T09:41:24.746215Z","steps":["trace[1647531623] 'process raft request' (duration: 230.711995ms)","trace[1647531623] 'compare' (duration: 10.195437ms)"],"step_count":2} {"level":"info","ts":"2026-09-06T09:41:27.825825Z","caller":"traceutil/trace.go:171","msg":"trace[171651491] linearizableReadLoop","detail":"{readStateIndex:2181; appliedIndex:2180; }","duration":"104.244404ms","start":"2026-09-06T09:41:27.72156Z","end":"2026-09-06T09:41:27.825805Z","steps":["trace[171651491] 'read index received' (duration: 104.047374ms)","trace[171651491] 'applied index is now lower than readState.Index' (duration: 196.2µs)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:41:27.826067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.487574ms","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-09-06T09:41:27.826061Z","caller":"traceutil/trace.go:171","msg":"trace[1015052829] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"182.27054ms","start":"2026-09-06T09:41:27.643751Z","end":"2026-09-06T09:41:27.826022Z","steps":["trace[1015052829] 'process raft request' (duration: 181.92017ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:27.826112Z","caller":"traceutil/trace.go:171","msg":"trace[2056023824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2099; }","duration":"104.545804ms","start":"2026-09-06T09:41:27.721554Z","end":"2026-09-06T09:41:27.8261Z","steps":["trace[2056023824] 'agreement among raft nodes before linearized reading' (duration: 104.331534ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:50.762538Z","caller":"traceutil/trace.go:171","msg":"trace[179197102] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"128.300014ms","start":"2026-09-06T09:41:50.634202Z","end":"2026-09-06T09:41:50.762502Z","steps":["trace[179197102] 'process raft request' (duration: 128.070892ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:51.264711Z","caller":"traceutil/trace.go:171","msg":"trace[1333577858] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"118.879772ms","start":"2026-09-06T09:41:51.145806Z","end":"2026-09-06T09:41:51.264686Z","steps":["trace[1333577858] 'process raft request' (duration: 118.735111ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:51.291612Z","caller":"traceutil/trace.go:171","msg":"trace[1251599391] linearizableReadLoop","detail":"{readStateIndex:2317; appliedIndex:2315; }","duration":"100.055208ms","start":"2026-09-06T09:41:51.191529Z","end":"2026-09-06T09:41:51.291584Z","steps":["trace[1251599391] 'read index received' (duration: 73.073847ms)","trace[1251599391] 'applied index is now lower than readState.Index' (duration: 26.979911ms)"],"step_count":2} {"level":"info","ts":"2026-09-06T09:41:51.29169Z","caller":"traceutil/trace.go:171","msg":"trace[484009496] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"140.487659ms","start":"2026-09-06T09:41:51.151169Z","end":"2026-09-06T09:41:51.291657Z","steps":["trace[484009496] 'process raft request' (duration: 140.169316ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:41:51.292012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.31155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-09-06T09:41:51.292078Z","caller":"traceutil/trace.go:171","msg":"trace[2079914234] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2230; }","duration":"100.583422ms","start":"2026-09-06T09:41:51.191476Z","end":"2026-09-06T09:41:51.292059Z","steps":["trace[2079914234] 'agreement among raft nodes before linearized reading' (duration: 100.238329ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:51.510866Z","caller":"traceutil/trace.go:171","msg":"trace[1566038434] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"214.553047ms","start":"2026-09-06T09:41:51.296287Z","end":"2026-09-06T09:41:51.51084Z","steps":["trace[1566038434] 'process raft request' (duration: 161.168ms)","trace[1566038434] 'compare' (duration: 53.266186ms)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:41:51.820165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.500787ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-06T09:41:51.820268Z","caller":"traceutil/trace.go:171","msg":"trace[661779377] linearizableReadLoop","detail":"{readStateIndex:2320; appliedIndex:2319; }","duration":"214.364414ms","start":"2026-09-06T09:41:51.605887Z","end":"2026-09-06T09:41:51.820252Z","steps":["trace[661779377] 'read index received' (duration: 38.506515ms)","trace[661779377] 'applied index is now lower than readState.Index' (duration: 175.856499ms)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:41:51.820453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.561086ms","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-06T09:41:51.820488Z","caller":"traceutil/trace.go:171","msg":"trace[597631343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2233; }","duration":"214.619927ms","start":"2026-09-06T09:41:51.605859Z","end":"2026-09-06T09:41:51.820479Z","steps":["trace[597631343] 'agreement among raft nodes before linearized reading' (duration: 214.436995ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:51.820322Z","caller":"traceutil/trace.go:171","msg":"trace[216186071] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"217.603351ms","start":"2026-09-06T09:41:51.602679Z","end":"2026-09-06T09:41:51.820282Z","steps":["trace[216186071] 'process raft request' (duration: 41.764832ms)","trace[216186071] 'compare' (duration: 175.322255ms)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:41:52.154106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.577081ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-06T09:41:52.154266Z","caller":"traceutil/trace.go:171","msg":"trace[1310228742] linearizableReadLoop","detail":"{readStateIndex:2322; appliedIndex:2320; }","duration":"215.289305ms","start":"2026-09-06T09:41:51.938959Z","end":"2026-09-06T09:41:52.154249Z","steps":["trace[1310228742] 'read index received' (duration: 62.534042ms)","trace[1310228742] 'applied index is now lower than readState.Index' (duration: 152.754233ms)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:41:52.154487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.516787ms","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-09-06T09:41:52.154554Z","caller":"traceutil/trace.go:171","msg":"trace[2070795653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2235; }","duration":"215.626088ms","start":"2026-09-06T09:41:51.938907Z","end":"2026-09-06T09:41:52.154533Z","steps":["trace[2070795653] 'agreement among raft nodes before linearized reading' (duration: 215.437626ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:52.154519Z","caller":"traceutil/trace.go:171","msg":"trace[364557725] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"249.382824ms","start":"2026-09-06T09:41:51.90501Z","end":"2026-09-06T09:41:52.154393Z","steps":["trace[364557725] 'process raft request' (duration: 249.193822ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:41:52.154645Z","caller":"traceutil/trace.go:171","msg":"trace[1658810455] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"329.249538ms","start":"2026-09-06T09:41:51.825289Z","end":"2026-09-06T09:41:52.154539Z","steps":["trace[1658810455] 'process raft request' (duration: 176.161812ms)","trace[1658810455] 'compare' (duration: 152.4366ms)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:41:52.155038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-06T09:41:51.825266Z","time spent":"329.634531ms","remote":"127.0.0.1:35530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-06T09:41:52.552202Z","caller":"traceutil/trace.go:171","msg":"trace[236950695] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"157.898257ms","start":"2026-09-06T09:41:52.394285Z","end":"2026-09-06T09:41:52.552183Z","steps":["trace[236950695] 'process raft request' (duration: 157.766346ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:42:46.801929Z","caller":"traceutil/trace.go:171","msg":"trace[1586489208] transaction","detail":"{read_only:false; response_revision:2636; number_of_response:1; }","duration":"262.357154ms","start":"2026-09-06T09:42:46.539544Z","end":"2026-09-06T09:42:46.801902Z","steps":["trace[1586489208] 'process raft request' (duration: 262.125739ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:43:21.96333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.346443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-06T09:43:21.963441Z","caller":"traceutil/trace.go:171","msg":"trace[1178736226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2827; }","duration":"199.561299ms","start":"2026-09-06T09:43:21.763851Z","end":"2026-09-06T09:43:21.963412Z","steps":["trace[1178736226] 'range keys from in-memory index tree' (duration: 199.105087ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:47:47.685004Z","caller":"traceutil/trace.go:171","msg":"trace[623467919] linearizableReadLoop","detail":"{readStateIndex:5032; appliedIndex:5031; }","duration":"107.168867ms","start":"2026-09-06T09:47:47.577817Z","end":"2026-09-06T09:47:47.684986Z","steps":["trace[623467919] 'read index received' (duration: 106.892125ms)","trace[623467919] 'applied index is now lower than readState.Index' (duration: 276.152µs)"],"step_count":2} {"level":"info","ts":"2026-09-06T09:47:47.68518Z","caller":"traceutil/trace.go:171","msg":"trace[1352190131] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"107.605205ms","start":"2026-09-06T09:47:47.57754Z","end":"2026-09-06T09:47:47.685145Z","steps":["trace[1352190131] 'process raft request' (duration: 107.25349ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:47:47.685346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.493461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-09-06T09:47:47.685377Z","caller":"traceutil/trace.go:171","msg":"trace[870610090] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4845; }","duration":"107.570263ms","start":"2026-09-06T09:47:47.577796Z","end":"2026-09-06T09:47:47.685367Z","steps":["trace[870610090] 'agreement among raft nodes before linearized reading' (duration: 107.276701ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:47:50.117021Z","caller":"traceutil/trace.go:171","msg":"trace[1660742615] linearizableReadLoop","detail":"{readStateIndex:5087; appliedIndex:5086; }","duration":"101.381818ms","start":"2026-09-06T09:47:50.015616Z","end":"2026-09-06T09:47:50.116998Z","steps":["trace[1660742615] 'read index received' (duration: 90.799122ms)","trace[1660742615] 'applied index is now lower than readState.Index' (duration: 10.581396ms)"],"step_count":2} {"level":"info","ts":"2026-09-06T09:47:50.117078Z","caller":"traceutil/trace.go:171","msg":"trace[693946262] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"101.717673ms","start":"2026-09-06T09:47:50.015323Z","end":"2026-09-06T09:47:50.117041Z","steps":["trace[693946262] 'process raft request' (duration: 91.140597ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:47:50.117278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.629078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-mmvtp\" ","response":"range_response_count:1 size:9757"} {"level":"info","ts":"2026-09-06T09:47:50.117317Z","caller":"traceutil/trace.go:171","msg":"trace[107685291] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-mmvtp; range_end:; response_count:1; response_revision:4896; }","duration":"101.718773ms","start":"2026-09-06T09:47:50.015586Z","end":"2026-09-06T09:47:50.117305Z","steps":["trace[107685291] 'agreement among raft nodes before linearized reading' (duration: 101.518614ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:47:55.085135Z","caller":"traceutil/trace.go:171","msg":"trace[1826659161] linearizableReadLoop","detail":"{readStateIndex:5219; appliedIndex:5218; }","duration":"146.121492ms","start":"2026-09-06T09:47:54.938986Z","end":"2026-09-06T09:47:55.085107Z","steps":["trace[1826659161] 'read index received' (duration: 146.023618ms)","trace[1826659161] 'applied index is now lower than readState.Index' (duration: 96.784µs)"],"step_count":2} {"level":"info","ts":"2026-09-06T09:47:55.085426Z","caller":"traceutil/trace.go:171","msg":"trace[2035559482] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"148.781595ms","start":"2026-09-06T09:47:54.936634Z","end":"2026-09-06T09:47:55.085416Z","steps":["trace[2035559482] 'process raft request' (duration: 148.313116ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:47:55.085711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.709288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-acacbdad-64dc-47fd-811d-0d55453b5589\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-06T09:47:55.085747Z","caller":"traceutil/trace.go:171","msg":"trace[1096399480] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-acacbdad-64dc-47fd-811d-0d55453b5589; range_end:; response_count:1; response_revision:5025; }","duration":"146.862334ms","start":"2026-09-06T09:47:54.938871Z","end":"2026-09-06T09:47:55.085733Z","steps":["trace[1096399480] 'agreement among raft nodes before linearized reading' (duration: 146.716748ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:47:55.162323Z","caller":"traceutil/trace.go:171","msg":"trace[61546754] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"101.379567ms","start":"2026-09-06T09:47:55.060916Z","end":"2026-09-06T09:47:55.162296Z","steps":["trace[61546754] 'process raft request' (duration: 41.995911ms)","trace[61546754] 'compare' (duration: 59.107414ms)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:47:55.162391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.909716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-06T09:47:55.162476Z","caller":"traceutil/trace.go:171","msg":"trace[1004715717] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:5026; }","duration":"197.049831ms","start":"2026-09-06T09:47:54.965405Z","end":"2026-09-06T09:47:55.162455Z","steps":["trace[1004715717] 'agreement among raft nodes before linearized reading' (duration: 196.854743ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:47:55.16256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.809977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-b7588f7bc-dhl92\" ","response":"range_response_count:1 size:11252"} {"level":"info","ts":"2026-09-06T09:47:55.16264Z","caller":"traceutil/trace.go:171","msg":"trace[893607379] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-b7588f7bc-dhl92; range_end:; response_count:1; response_revision:5026; }","duration":"102.948383ms","start":"2026-09-06T09:47:55.059671Z","end":"2026-09-06T09:47:55.162619Z","steps":["trace[893607379] 'agreement among raft nodes before linearized reading' (duration: 102.671252ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:48:09.109353Z","caller":"traceutil/trace.go:171","msg":"trace[802255698] linearizableReadLoop","detail":"{readStateIndex:5417; appliedIndex:5416; }","duration":"232.571879ms","start":"2026-09-06T09:48:08.87676Z","end":"2026-09-06T09:48:09.109332Z","steps":["trace[802255698] 'read index received' (duration: 232.34441ms)","trace[802255698] 'applied index is now lower than readState.Index' (duration: 226.699µs)"],"step_count":2} {"level":"warn","ts":"2026-09-06T09:48:09.109527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.754787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-06T09:48:09.109586Z","caller":"traceutil/trace.go:171","msg":"trace[503410662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5216; }","duration":"232.857151ms","start":"2026-09-06T09:48:08.876716Z","end":"2026-09-06T09:48:09.109573Z","steps":["trace[503410662] 'agreement among raft nodes before linearized reading' (duration: 232.762447ms)"],"step_count":1} {"level":"info","ts":"2026-09-06T09:48:09.109689Z","caller":"traceutil/trace.go:171","msg":"trace[1998930744] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"362.100649ms","start":"2026-09-06T09:48:08.747566Z","end":"2026-09-06T09:48:09.109667Z","steps":["trace[1998930744] 'process raft request' (duration: 361.580827ms)"],"step_count":1} {"level":"warn","ts":"2026-09-06T09:48:09.109851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-06T09:48:08.747544Z","time spent":"362.237065ms","remote":"127.0.0.1:35530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-06T09:48:09.516919Z","caller":"traceutil/trace.go:171","msg":"trace[2144027603] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"135.928803ms","start":"2026-09-06T09:48:09.380957Z","end":"2026-09-06T09:48:09.516886Z","steps":["trace[2144027603] 'process raft request' (duration: 87.829874ms)","trace[2144027603] 'compare' (duration: 47.682582ms)"],"step_count":2} {"level":"info","ts":"2026-09-06T09:48:18.980285Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2813} {"level":"info","ts":"2026-09-06T09:48:19.059689Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2813,"took":"77.926655ms","hash":702956254,"current-db-size-bytes":51777536,"current-db-size":"52 MB","current-db-size-in-use-bytes":27455488,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-06T09:48:19.05976Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":702956254,"revision":2813,"compact-revision":-1} {"level":"info","ts":"2026-09-06T09:52:15.564189Z","caller":"traceutil/trace.go:171","msg":"trace[335783035] transaction","detail":"{read_only:false; response_revision:6999; number_of_response:1; }","duration":"105.871369ms","start":"2026-09-06T09:52:15.45829Z","end":"2026-09-06T09:52:15.564162Z","steps":["trace[335783035] 'process raft request' (duration: 64.74709ms)","trace[335783035] 'compare' (duration: 41.032667ms)"],"step_count":2} {"level":"info","ts":"2026-09-06T09:53:18.989687Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5287} {"level":"info","ts":"2026-09-06T09:53:19.069805Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5287,"took":"78.402015ms","hash":3349893693,"current-db-size-bytes":51777536,"current-db-size":"52 MB","current-db-size-in-use-bytes":18751488,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-06T09:53:19.069855Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3349893693,"revision":5287,"compact-revision":2813}