{"level":"warn","ts":"2026-04-15T07:31:49.931561Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-15T07:31:49.931699Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.134:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.134:2380","--initial-cluster=instance=https://199.19.213.134:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.134:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.134: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-04-15T07:31:49.931836Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-15T07:31:49.931859Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.134:2380"]} {"level":"info","ts":"2026-04-15T07:31:49.931894Z","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-04-15T07:31:49.933155Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"]} {"level":"info","ts":"2026-04-15T07:31:49.933317Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.134:2380"],"listen-peer-urls":["https://199.19.213.134:2380"],"advertise-client-urls":["https://199.19.213.134:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.134: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-04-15T07:31:49.962609Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"28.916437ms"} {"level":"info","ts":"2026-04-15T07:31:49.993993Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"92da22d3868c86fb","cluster-id":"84450b28e935eb90"} {"level":"info","ts":"2026-04-15T07:31:49.994153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=()"} {"level":"info","ts":"2026-04-15T07:31:49.994197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became follower at term 0"} {"level":"info","ts":"2026-04-15T07:31:49.994227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 92da22d3868c86fb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-15T07:31:49.994243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became follower at term 1"} {"level":"info","ts":"2026-04-15T07:31:49.994319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=(10581808566351202043)"} {"level":"warn","ts":"2026-04-15T07:31:50.005368Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-15T07:31:50.011559Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-15T07:31:50.017423Z","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-04-15T07:31:50.020376Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"92da22d3868c86fb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-15T07:31:50.020672Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"92da22d3868c86fb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-15T07:31:50.020806Z","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-04-15T07:31:50.020968Z","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-04-15T07:31:50.02099Z","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-04-15T07:31:50.025835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=(10581808566351202043)"} {"level":"info","ts":"2026-04-15T07:31:50.025997Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"84450b28e935eb90","local-member-id":"92da22d3868c86fb","added-peer-id":"92da22d3868c86fb","added-peer-peer-urls":["https://199.19.213.134:2380"]} {"level":"info","ts":"2026-04-15T07:31:50.027503Z","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-04-15T07:31:50.027579Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.134:2380"} {"level":"info","ts":"2026-04-15T07:31:50.027649Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.134:2380"} {"level":"info","ts":"2026-04-15T07:31:50.028956Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-15T07:31:50.028908Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"92da22d3868c86fb","initial-advertise-peer-urls":["https://199.19.213.134:2380"],"listen-peer-urls":["https://199.19.213.134:2380"],"advertise-client-urls":["https://199.19.213.134:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-15T07:31:50.995473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb is starting a new election at term 1"} {"level":"info","ts":"2026-04-15T07:31:50.995536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-15T07:31:50.995562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb received MsgPreVoteResp from 92da22d3868c86fb at term 1"} {"level":"info","ts":"2026-04-15T07:31:50.995584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became candidate at term 2"} {"level":"info","ts":"2026-04-15T07:31:50.995607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb received MsgVoteResp from 92da22d3868c86fb at term 2"} {"level":"info","ts":"2026-04-15T07:31:50.995638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became leader at term 2"} {"level":"info","ts":"2026-04-15T07:31:50.99566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 92da22d3868c86fb elected leader 92da22d3868c86fb at term 2"} {"level":"info","ts":"2026-04-15T07:31:50.996703Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"92da22d3868c86fb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.134:2379]}","request-path":"/0/members/92da22d3868c86fb/attributes","cluster-id":"84450b28e935eb90","publish-timeout":"7s"} {"level":"info","ts":"2026-04-15T07:31:50.996754Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T07:31:50.99679Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T07:31:50.996907Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:31:50.997039Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-15T07:31:50.997204Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-15T07:31:50.997601Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"84450b28e935eb90","local-member-id":"92da22d3868c86fb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:31:50.997681Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:31:50.997706Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:31:51.000445Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.134:2379"} {"level":"info","ts":"2026-04-15T07:31:51.001284Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-15T07:32:07.212967Z","caller":"traceutil/trace.go:171","msg":"trace[861673988] linearizableReadLoop","detail":"{readStateIndex:396; appliedIndex:395; }","duration":"177.515086ms","start":"2026-04-15T07:32:07.035424Z","end":"2026-04-15T07:32:07.212939Z","steps":["trace[861673988] 'read index received' (duration: 177.29908ms)","trace[861673988] 'applied index is now lower than readState.Index' (duration: 215.046µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:32:07.213126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.67956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:32:07.213192Z","caller":"traceutil/trace.go:171","msg":"trace[893172530] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:380; }","duration":"177.808395ms","start":"2026-04-15T07:32:07.035373Z","end":"2026-04-15T07:32:07.213181Z","steps":["trace[893172530] 'agreement among raft nodes before linearized reading' (duration: 177.697522ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:07.213321Z","caller":"traceutil/trace.go:171","msg":"trace[1610901203] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"217.242002ms","start":"2026-04-15T07:32:06.99604Z","end":"2026-04-15T07:32:07.213282Z","steps":["trace[1610901203] 'process raft request' (duration: 216.741438ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:07.465423Z","caller":"traceutil/trace.go:171","msg":"trace[1260897310] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"245.863911ms","start":"2026-04-15T07:32:07.219528Z","end":"2026-04-15T07:32:07.465392Z","steps":["trace[1260897310] 'process raft request' (duration: 245.722157ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:07.581764Z","caller":"traceutil/trace.go:171","msg":"trace[736864290] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"112.269591ms","start":"2026-04-15T07:32:07.469468Z","end":"2026-04-15T07:32:07.581738Z","steps":["trace[736864290] 'process raft request' (duration: 111.744145ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:07.585516Z","caller":"traceutil/trace.go:171","msg":"trace[1721086244] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"115.239816ms","start":"2026-04-15T07:32:07.470257Z","end":"2026-04-15T07:32:07.585497Z","steps":["trace[1721086244] 'process raft request' (duration: 114.992829ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:07.585519Z","caller":"traceutil/trace.go:171","msg":"trace[1306934482] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"112.827697ms","start":"2026-04-15T07:32:07.47266Z","end":"2026-04-15T07:32:07.585488Z","steps":["trace[1306934482] 'process raft request' (duration: 112.736044ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:27.456937Z","caller":"traceutil/trace.go:171","msg":"trace[1964544995] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"116.537362ms","start":"2026-04-15T07:32:27.340371Z","end":"2026-04-15T07:32:27.456909Z","steps":["trace[1964544995] 'process raft request' (duration: 116.352557ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:27.578145Z","caller":"traceutil/trace.go:171","msg":"trace[1407082532] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"224.602224ms","start":"2026-04-15T07:32:27.353519Z","end":"2026-04-15T07:32:27.578121Z","steps":["trace[1407082532] 'process raft request' (duration: 216.7948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:32:28.132494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.899573ms","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-04-15T07:32:28.13264Z","caller":"traceutil/trace.go:171","msg":"trace[2132172790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"138.09739ms","start":"2026-04-15T07:32:27.994514Z","end":"2026-04-15T07:32:28.132611Z","steps":["trace[2132172790] 'range keys from in-memory index tree' (duration: 137.676797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:32:28.607546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.436378ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T07:32:28.607754Z","caller":"traceutil/trace.go:171","msg":"trace[1331948305] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"401.721398ms","start":"2026-04-15T07:32:28.206011Z","end":"2026-04-15T07:32:28.607733Z","steps":["trace[1331948305] 'process raft request' (duration: 401.644816ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:28.607773Z","caller":"traceutil/trace.go:171","msg":"trace[346683711] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"403.898371ms","start":"2026-04-15T07:32:28.203832Z","end":"2026-04-15T07:32:28.60773Z","steps":["trace[346683711] 'process raft request' (duration: 99.606039ms)","trace[346683711] 'compare' (duration: 302.652126ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:32:28.607849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:32:28.206005Z","time spent":"401.80557ms","remote":"127.0.0.1:56504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T07:32:28.608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:32:28.20381Z","time spent":"404.071835ms","remote":"127.0.0.1:56520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T07:32:44.512926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.740665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.134\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-15T07:32:44.513028Z","caller":"traceutil/trace.go:171","msg":"trace[335610503] range","detail":"{range_begin:/registry/masterleases/199.19.213.134; range_end:; response_count:1; response_revision:746; }","duration":"249.884859ms","start":"2026-04-15T07:32:44.26312Z","end":"2026-04-15T07:32:44.513005Z","steps":["trace[335610503] 'range keys from in-memory index tree' (duration: 249.53458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:32:44.513024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.34156ms","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-04-15T07:32:44.513114Z","caller":"traceutil/trace.go:171","msg":"trace[1741501477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:746; }","duration":"232.488874ms","start":"2026-04-15T07:32:44.280604Z","end":"2026-04-15T07:32:44.513093Z","steps":["trace[1741501477] 'range keys from in-memory index tree' (duration: 232.136175ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:48.840675Z","caller":"traceutil/trace.go:171","msg":"trace[769738309] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"109.232942ms","start":"2026-04-15T07:32:48.731407Z","end":"2026-04-15T07:32:48.84064Z","steps":["trace[769738309] 'process raft request' (duration: 89.795769ms)","trace[769738309] 'compare' (duration: 19.165496ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:32:48.840876Z","caller":"traceutil/trace.go:171","msg":"trace[24304166] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"105.335082ms","start":"2026-04-15T07:32:48.735492Z","end":"2026-04-15T07:32:48.840827Z","steps":["trace[24304166] 'process raft request' (duration: 105.25834ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:48.840933Z","caller":"traceutil/trace.go:171","msg":"trace[427482509] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"106.071252ms","start":"2026-04-15T07:32:48.734833Z","end":"2026-04-15T07:32:48.840904Z","steps":["trace[427482509] 'process raft request' (duration: 105.811305ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:32:48.840907Z","caller":"traceutil/trace.go:171","msg":"trace[596429626] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"106.640068ms","start":"2026-04-15T07:32:48.734236Z","end":"2026-04-15T07:32:48.840876Z","steps":["trace[596429626] 'process raft request' (duration: 106.323999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:33:57.102638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.624079ms","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-04-15T07:33:57.102738Z","caller":"traceutil/trace.go:171","msg":"trace[331263920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1804; }","duration":"187.753412ms","start":"2026-04-15T07:33:56.914959Z","end":"2026-04-15T07:33:57.102712Z","steps":["trace[331263920] 'range keys from in-memory index tree' (duration: 187.489135ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:10.172286Z","caller":"traceutil/trace.go:171","msg":"trace[121258841] linearizableReadLoop","detail":"{readStateIndex:1993; appliedIndex:1992; }","duration":"135.432534ms","start":"2026-04-15T07:34:10.036826Z","end":"2026-04-15T07:34:10.172258Z","steps":["trace[121258841] 'read index received' (duration: 129.967032ms)","trace[121258841] 'applied index is now lower than readState.Index' (duration: 5.464412ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:34:10.172444Z","caller":"traceutil/trace.go:171","msg":"trace[975440729] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"136.249537ms","start":"2026-04-15T07:34:10.03618Z","end":"2026-04-15T07:34:10.17243Z","steps":["trace[975440729] 'process raft request' (duration: 130.660581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:10.172532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.32789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:34:10.172594Z","caller":"traceutil/trace.go:171","msg":"trace[1776162301] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1919; }","duration":"117.400552ms","start":"2026-04-15T07:34:10.055179Z","end":"2026-04-15T07:34:10.172579Z","steps":["trace[1776162301] 'agreement among raft nodes before linearized reading' (duration: 117.292339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:10.172639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.787434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:34:10.172723Z","caller":"traceutil/trace.go:171","msg":"trace[13418613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1919; }","duration":"135.929467ms","start":"2026-04-15T07:34:10.036773Z","end":"2026-04-15T07:34:10.172702Z","steps":["trace[13418613] 'agreement among raft nodes before linearized reading' (duration: 135.772283ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:47.674402Z","caller":"traceutil/trace.go:171","msg":"trace[1371062571] linearizableReadLoop","detail":"{readStateIndex:2216; appliedIndex:2215; }","duration":"163.18757ms","start":"2026-04-15T07:34:47.511187Z","end":"2026-04-15T07:34:47.674375Z","steps":["trace[1371062571] 'read index received' (duration: 162.901362ms)","trace[1371062571] 'applied index is now lower than readState.Index' (duration: 284.748µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:34:47.674558Z","caller":"traceutil/trace.go:171","msg":"trace[82080893] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"173.688871ms","start":"2026-04-15T07:34:47.500858Z","end":"2026-04-15T07:34:47.674547Z","steps":["trace[82080893] 'process raft request' (duration: 173.319281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:47.675035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.310159ms","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-04-15T07:34:47.675169Z","caller":"traceutil/trace.go:171","msg":"trace[778250952] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2135; }","duration":"145.519444ms","start":"2026-04-15T07:34:47.529626Z","end":"2026-04-15T07:34:47.675146Z","steps":["trace[778250952] 'agreement among raft nodes before linearized reading' (duration: 145.069502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:47.675157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.930779ms","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-04-15T07:34:47.67543Z","caller":"traceutil/trace.go:171","msg":"trace[1856821969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2135; }","duration":"164.239488ms","start":"2026-04-15T07:34:47.511106Z","end":"2026-04-15T07:34:47.675345Z","steps":["trace[1856821969] 'agreement among raft nodes before linearized reading' (duration: 163.676602ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:35:39.920693Z","caller":"traceutil/trace.go:171","msg":"trace[428605253] transaction","detail":"{read_only:false; response_revision:2591; number_of_response:1; }","duration":"117.407691ms","start":"2026-04-15T07:35:39.803255Z","end":"2026-04-15T07:35:39.920663Z","steps":["trace[428605253] 'process raft request' (duration: 117.211575ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:36:14.310918Z","caller":"traceutil/trace.go:171","msg":"trace[1877459455] linearizableReadLoop","detail":"{readStateIndex:2905; appliedIndex:2902; }","duration":"164.79387ms","start":"2026-04-15T07:36:14.14609Z","end":"2026-04-15T07:36:14.310884Z","steps":["trace[1877459455] 'read index received' (duration: 20.879536ms)","trace[1877459455] 'applied index is now lower than readState.Index' (duration: 143.912994ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:36:14.311007Z","caller":"traceutil/trace.go:171","msg":"trace[803860198] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"185.594185ms","start":"2026-04-15T07:36:14.125343Z","end":"2026-04-15T07:36:14.310937Z","steps":["trace[803860198] 'process raft request' (duration: 185.303037ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:36:14.311057Z","caller":"traceutil/trace.go:171","msg":"trace[883407197] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"185.336099ms","start":"2026-04-15T07:36:14.125678Z","end":"2026-04-15T07:36:14.311014Z","steps":["trace[883407197] 'process raft request' (duration: 185.155344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:36:14.311426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.318652ms","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-04-15T07:36:14.311464Z","caller":"traceutil/trace.go:171","msg":"trace[1817335100] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2798; }","duration":"165.389754ms","start":"2026-04-15T07:36:14.146061Z","end":"2026-04-15T07:36:14.31145Z","steps":["trace[1817335100] 'agreement among raft nodes before linearized reading' (duration: 165.242381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:36:14.573491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.947026ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-15T07:36:14.573761Z","caller":"traceutil/trace.go:171","msg":"trace[847500207] transaction","detail":"{read_only:false; response_revision:2799; number_of_response:1; }","duration":"132.979672ms","start":"2026-04-15T07:36:14.44076Z","end":"2026-04-15T07:36:14.57374Z","steps":["trace[847500207] 'process raft request' (duration: 132.840199ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:36:14.573996Z","caller":"traceutil/trace.go:171","msg":"trace[1912174404] linearizableReadLoop","detail":"{readStateIndex:2906; appliedIndex:2905; }","duration":"259.014842ms","start":"2026-04-15T07:36:14.314951Z","end":"2026-04-15T07:36:14.573966Z","steps":["trace[1912174404] 'read index received' (duration: 105.499022ms)","trace[1912174404] 'applied index is now lower than readState.Index' (duration: 153.51302ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:36:14.574409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.448733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1445"} {"level":"info","ts":"2026-04-15T07:36:14.574469Z","caller":"traceutil/trace.go:171","msg":"trace[589654476] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2799; }","duration":"259.561766ms","start":"2026-04-15T07:36:14.314894Z","end":"2026-04-15T07:36:14.574456Z","steps":["trace[589654476] 'agreement among raft nodes before linearized reading' (duration: 259.173795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:40:14.164498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.176299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777693"} {"level":"info","ts":"2026-04-15T07:40:14.164611Z","caller":"traceutil/trace.go:171","msg":"trace[1194055231] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5004; }","duration":"133.316282ms","start":"2026-04-15T07:40:14.031272Z","end":"2026-04-15T07:40:14.164588Z","steps":["trace[1194055231] 'range keys from in-memory index tree' (duration: 132.321316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:40:14.164849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.135895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:40:14.164941Z","caller":"traceutil/trace.go:171","msg":"trace[2029772940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5004; }","duration":"128.293029ms","start":"2026-04-15T07:40:14.036627Z","end":"2026-04-15T07:40:14.16492Z","steps":["trace[2029772940] 'range keys from in-memory index tree' (duration: 128.004861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:40:14.164976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.293545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-04-15T07:40:14.165084Z","caller":"traceutil/trace.go:171","msg":"trace[180691501] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5004; }","duration":"132.436459ms","start":"2026-04-15T07:40:14.032625Z","end":"2026-04-15T07:40:14.165061Z","steps":["trace[180691501] 'range keys from in-memory index tree' (duration: 132.139561ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:40:25.073513Z","caller":"traceutil/trace.go:171","msg":"trace[209283942] transaction","detail":"{read_only:false; response_revision:5221; number_of_response:1; }","duration":"100.784921ms","start":"2026-04-15T07:40:24.972704Z","end":"2026-04-15T07:40:25.073489Z","steps":["trace[209283942] 'process raft request' (duration: 100.249437ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:40:25.285536Z","caller":"traceutil/trace.go:171","msg":"trace[499083157] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"197.442112ms","start":"2026-04-15T07:40:25.08806Z","end":"2026-04-15T07:40:25.285502Z","steps":["trace[499083157] 'process raft request' (duration: 182.485726ms)","trace[499083157] 'compare' (duration: 14.607216ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:40:25.28577Z","caller":"traceutil/trace.go:171","msg":"trace[1438460451] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"197.172424ms","start":"2026-04-15T07:40:25.088583Z","end":"2026-04-15T07:40:25.285755Z","steps":["trace[1438460451] 'process raft request' (duration: 196.875376ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:40:25.285973Z","caller":"traceutil/trace.go:171","msg":"trace[849631241] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"196.842606ms","start":"2026-04-15T07:40:25.089091Z","end":"2026-04-15T07:40:25.285934Z","steps":["trace[849631241] 'process raft request' (duration: 196.568989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:40:33.178418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.748898ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T07:40:33.178584Z","caller":"traceutil/trace.go:171","msg":"trace[387089563] linearizableReadLoop","detail":"{readStateIndex:5591; appliedIndex:5590; }","duration":"144.12131ms","start":"2026-04-15T07:40:33.034441Z","end":"2026-04-15T07:40:33.178562Z","steps":["trace[387089563] 'read index received' (duration: 50.042µs)","trace[387089563] 'applied index is now lower than readState.Index' (duration: 144.069398ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:40:33.178656Z","caller":"traceutil/trace.go:171","msg":"trace[454751738] transaction","detail":"{read_only:false; response_revision:5391; number_of_response:1; }","duration":"163.347609ms","start":"2026-04-15T07:40:33.015252Z","end":"2026-04-15T07:40:33.1786Z","steps":["trace[454751738] 'process raft request' (duration: 13.269312ms)","trace[454751738] 'compare' (duration: 149.557482ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:40:33.179335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.873329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:40:33.179393Z","caller":"traceutil/trace.go:171","msg":"trace[1162224506] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5391; }","duration":"144.994202ms","start":"2026-04-15T07:40:33.034381Z","end":"2026-04-15T07:40:33.179375Z","steps":["trace[1162224506] 'agreement among raft nodes before linearized reading' (duration: 144.293724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:40:33.702917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.489016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-15T07:40:33.703021Z","caller":"traceutil/trace.go:171","msg":"trace[594110401] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:5391; }","duration":"316.704641ms","start":"2026-04-15T07:40:33.386296Z","end":"2026-04-15T07:40:33.703001Z","steps":["trace[594110401] 'count revisions from in-memory index tree' (duration: 316.360623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:40:33.703003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.865341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d8gb2\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-04-15T07:40:33.703069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:40:33.386266Z","time spent":"316.792584ms","remote":"127.0.0.1:56362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":92,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-04-15T07:40:33.703116Z","caller":"traceutil/trace.go:171","msg":"trace[249154027] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d8gb2; range_end:; response_count:1; response_revision:5391; }","duration":"264.049247ms","start":"2026-04-15T07:40:33.439044Z","end":"2026-04-15T07:40:33.703093Z","steps":["trace[249154027] 'range keys from in-memory index tree' (duration: 263.630715ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:40:33.731261Z","caller":"traceutil/trace.go:171","msg":"trace[1791813211] linearizableReadLoop","detail":"{readStateIndex:5592; appliedIndex:5591; }","duration":"215.87751ms","start":"2026-04-15T07:40:33.515346Z","end":"2026-04-15T07:40:33.731224Z","steps":["trace[1791813211] 'read index received' (duration: 215.412378ms)","trace[1791813211] 'applied index is now lower than readState.Index' (duration: 463.552µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:40:33.731355Z","caller":"traceutil/trace.go:171","msg":"trace[207137031] transaction","detail":"{read_only:false; response_revision:5392; number_of_response:1; }","duration":"229.018999ms","start":"2026-04-15T07:40:33.502308Z","end":"2026-04-15T07:40:33.731327Z","steps":["trace[207137031] 'process raft request' (duration: 228.485435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:40:33.731607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.231199ms","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-04-15T07:40:33.731721Z","caller":"traceutil/trace.go:171","msg":"trace[164606470] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5392; }","duration":"216.419094ms","start":"2026-04-15T07:40:33.515267Z","end":"2026-04-15T07:40:33.731686Z","steps":["trace[164606470] 'agreement among raft nodes before linearized reading' (duration: 216.087076ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:40:33.73959Z","caller":"traceutil/trace.go:171","msg":"trace[334919416] transaction","detail":"{read_only:false; response_revision:5393; number_of_response:1; }","duration":"194.279077ms","start":"2026-04-15T07:40:33.545281Z","end":"2026-04-15T07:40:33.73956Z","steps":["trace[334919416] 'process raft request' (duration: 194.093052ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:40:33.739878Z","caller":"traceutil/trace.go:171","msg":"trace[1135643153] transaction","detail":"{read_only:false; response_revision:5394; number_of_response:1; }","duration":"190.427186ms","start":"2026-04-15T07:40:33.549437Z","end":"2026-04-15T07:40:33.739865Z","steps":["trace[1135643153] 'process raft request' (duration: 190.072227ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:40:33.913467Z","caller":"traceutil/trace.go:171","msg":"trace[1656343467] transaction","detail":"{read_only:false; response_revision:5397; number_of_response:1; }","duration":"167.992222ms","start":"2026-04-15T07:40:33.745424Z","end":"2026-04-15T07:40:33.913416Z","steps":["trace[1656343467] 'process raft request' (duration: 167.681884ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:40:33.913563Z","caller":"traceutil/trace.go:171","msg":"trace[1867074638] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"168.044662ms","start":"2026-04-15T07:40:33.745478Z","end":"2026-04-15T07:40:33.913522Z","steps":["trace[1867074638] 'process raft request' (duration: 167.886678ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:41:51.025792Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3002} {"level":"info","ts":"2026-04-15T07:41:51.113006Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3002,"took":"85.02204ms","hash":2848812343,"current-db-size-bytes":57274368,"current-db-size":"57 MB","current-db-size-in-use-bytes":31252480,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-15T07:41:51.113078Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2848812343,"revision":3002,"compact-revision":-1} {"level":"info","ts":"2026-04-15T07:44:25.725523Z","caller":"traceutil/trace.go:171","msg":"trace[1225855162] transaction","detail":"{read_only:false; response_revision:7032; number_of_response:1; }","duration":"132.924136ms","start":"2026-04-15T07:44:25.592575Z","end":"2026-04-15T07:44:25.725499Z","steps":["trace[1225855162] 'process raft request' (duration: 132.389962ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:46:51.031311Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6055} {"level":"info","ts":"2026-04-15T07:46:51.13585Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6055,"took":"102.929333ms","hash":1604066177,"current-db-size-bytes":57274368,"current-db-size":"57 MB","current-db-size-in-use-bytes":23764992,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-15T07:46:51.135912Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1604066177,"revision":6055,"compact-revision":3002} {"level":"info","ts":"2026-04-15T07:46:54.935393Z","caller":"traceutil/trace.go:171","msg":"trace[1426544641] transaction","detail":"{read_only:false; response_revision:8300; number_of_response:1; }","duration":"181.999276ms","start":"2026-04-15T07:46:54.753363Z","end":"2026-04-15T07:46:54.935362Z","steps":["trace[1426544641] 'process raft request' (duration: 101.313839ms)","trace[1426544641] 'compare' (duration: 79.975378ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:47:36.232218Z","caller":"traceutil/trace.go:171","msg":"trace[1400916068] linearizableReadLoop","detail":"{readStateIndex:8876; appliedIndex:8875; }","duration":"198.233388ms","start":"2026-04-15T07:47:36.033954Z","end":"2026-04-15T07:47:36.232187Z","steps":["trace[1400916068] 'read index received' (duration: 197.938639ms)","trace[1400916068] 'applied index is now lower than readState.Index' (duration: 292.889µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:47:36.232471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.463074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:47:36.232635Z","caller":"traceutil/trace.go:171","msg":"trace[1267352479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8573; }","duration":"198.66586ms","start":"2026-04-15T07:47:36.033931Z","end":"2026-04-15T07:47:36.232597Z","steps":["trace[1267352479] 'agreement among raft nodes before linearized reading' (duration: 198.377592ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:47:36.232339Z","caller":"traceutil/trace.go:171","msg":"trace[1715234169] transaction","detail":"{read_only:false; response_revision:8573; number_of_response:1; }","duration":"206.214405ms","start":"2026-04-15T07:47:36.026069Z","end":"2026-04-15T07:47:36.232284Z","steps":["trace[1715234169] 'process raft request' (duration: 205.923526ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:47:36.439116Z","caller":"traceutil/trace.go:171","msg":"trace[584693139] linearizableReadLoop","detail":"{readStateIndex:8877; appliedIndex:8876; }","duration":"128.395026ms","start":"2026-04-15T07:47:36.310696Z","end":"2026-04-15T07:47:36.439091Z","steps":["trace[584693139] 'read index received' (duration: 68.630229ms)","trace[584693139] 'applied index is now lower than readState.Index' (duration: 59.763697ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:47:36.439311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.601041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:47:36.439412Z","caller":"traceutil/trace.go:171","msg":"trace[1586998893] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:8574; }","duration":"128.820737ms","start":"2026-04-15T07:47:36.310572Z","end":"2026-04-15T07:47:36.439392Z","steps":["trace[1586998893] 'agreement among raft nodes before linearized reading' (duration: 128.665873ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:47:36.439643Z","caller":"traceutil/trace.go:171","msg":"trace[1710563164] transaction","detail":"{read_only:false; response_revision:8574; number_of_response:1; }","duration":"193.738246ms","start":"2026-04-15T07:47:36.245891Z","end":"2026-04-15T07:47:36.439629Z","steps":["trace[1710563164] 'process raft request' (duration: 133.410023ms)","trace[1710563164] 'compare' (duration: 59.676515ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:47:50.342662Z","caller":"traceutil/trace.go:171","msg":"trace[779050954] linearizableReadLoop","detail":"{readStateIndex:8998; appliedIndex:8997; }","duration":"151.719842ms","start":"2026-04-15T07:47:50.190919Z","end":"2026-04-15T07:47:50.342639Z","steps":["trace[779050954] 'read index received' (duration: 151.583569ms)","trace[779050954] 'applied index is now lower than readState.Index' (duration: 135.223µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:47:50.342817Z","caller":"traceutil/trace.go:171","msg":"trace[814697469] transaction","detail":"{read_only:false; response_revision:8690; number_of_response:1; }","duration":"211.107337ms","start":"2026-04-15T07:47:50.131694Z","end":"2026-04-15T07:47:50.342801Z","steps":["trace[814697469] 'process raft request' (duration: 210.784317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:47:50.343151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.206686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-15T07:47:50.343247Z","caller":"traceutil/trace.go:171","msg":"trace[33458404] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8690; }","duration":"152.3295ms","start":"2026-04-15T07:47:50.190893Z","end":"2026-04-15T07:47:50.343222Z","steps":["trace[33458404] 'agreement among raft nodes before linearized reading' (duration: 152.048573ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:48:07.335259Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d5.wal"} {"level":"warn","ts":"2026-04-15T07:48:49.609859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.026803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:48:49.610002Z","caller":"traceutil/trace.go:171","msg":"trace[1809124893] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:9315; }","duration":"197.232199ms","start":"2026-04-15T07:48:49.412737Z","end":"2026-04-15T07:48:49.60997Z","steps":["trace[1809124893] 'count revisions from in-memory index tree' (duration: 196.90621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:48:49.610469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.494609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-15T07:48:49.610529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.448407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-7f6d87684f-w2tvb.18a6784097bdf4cc\" ","response":"range_response_count:1 size:787"} {"level":"info","ts":"2026-04-15T07:48:49.610588Z","caller":"traceutil/trace.go:171","msg":"trace[1648939546] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9315; }","duration":"189.699965ms","start":"2026-04-15T07:48:49.420865Z","end":"2026-04-15T07:48:49.610565Z","steps":["trace[1648939546] 'range keys from in-memory index tree' (duration: 189.16264ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:48:49.61066Z","caller":"traceutil/trace.go:171","msg":"trace[766817253] range","detail":"{range_begin:/registry/events/openstack/glance-api-7f6d87684f-w2tvb.18a6784097bdf4cc; range_end:; response_count:1; response_revision:9315; }","duration":"122.671323ms","start":"2026-04-15T07:48:49.487958Z","end":"2026-04-15T07:48:49.610629Z","steps":["trace[766817253] 'range keys from in-memory index tree' (duration: 122.15298ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:49:08.146245Z","caller":"traceutil/trace.go:171","msg":"trace[1807325986] transaction","detail":"{read_only:false; response_revision:9446; number_of_response:1; }","duration":"120.131045ms","start":"2026-04-15T07:49:08.026075Z","end":"2026-04-15T07:49:08.146206Z","steps":["trace[1807325986] 'process raft request' (duration: 119.553279ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:49:08.178961Z","caller":"traceutil/trace.go:171","msg":"trace[448276157] transaction","detail":"{read_only:false; response_revision:9448; number_of_response:1; }","duration":"138.185844ms","start":"2026-04-15T07:49:08.040736Z","end":"2026-04-15T07:49:08.178922Z","steps":["trace[448276157] 'process raft request' (duration: 138.062661ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:49:08.179153Z","caller":"traceutil/trace.go:171","msg":"trace[153865185] transaction","detail":"{read_only:false; response_revision:9449; number_of_response:1; }","duration":"138.149373ms","start":"2026-04-15T07:49:08.040966Z","end":"2026-04-15T07:49:08.179115Z","steps":["trace[153865185] 'process raft request' (duration: 137.905987ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:49:08.178988Z","caller":"traceutil/trace.go:171","msg":"trace[1999905374] transaction","detail":"{read_only:false; response_revision:9447; number_of_response:1; }","duration":"138.730249ms","start":"2026-04-15T07:49:08.040221Z","end":"2026-04-15T07:49:08.178951Z","steps":["trace[1999905374] 'process raft request' (duration: 138.377489ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:49:38.951079Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"92da22d3868c86fb","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-15T07:49:38.958256Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-15T07:49:38.958479Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-15T07:50:46.261204Z","caller":"traceutil/trace.go:171","msg":"trace[1987518377] transaction","detail":"{read_only:false; response_revision:10126; number_of_response:1; }","duration":"641.680307ms","start":"2026-04-15T07:50:45.619493Z","end":"2026-04-15T07:50:46.261173Z","steps":["trace[1987518377] 'process raft request' (duration: 640.387412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:50:46.26144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:50:45.619483Z","time spent":"641.822481ms","remote":"127.0.0.1:56468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9590,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:50:46.262474Z","caller":"traceutil/trace.go:171","msg":"trace[557133696] transaction","detail":"{read_only:false; response_revision:10128; number_of_response:1; }","duration":"369.456842ms","start":"2026-04-15T07:50:45.893Z","end":"2026-04-15T07:50:46.262457Z","steps":["trace[557133696] 'process raft request' (duration: 369.117793ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:50:46.262461Z","caller":"traceutil/trace.go:171","msg":"trace[999107360] linearizableReadLoop","detail":"{readStateIndex:10477; appliedIndex:10474; }","duration":"361.98878ms","start":"2026-04-15T07:50:45.900446Z","end":"2026-04-15T07:50:46.262435Z","steps":["trace[999107360] 'read index received' (duration: 359.42571ms)","trace[999107360] 'applied index is now lower than readState.Index' (duration: 2.56222ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:50:46.262773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.315838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d8gb2\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-15T07:50:46.262859Z","caller":"traceutil/trace.go:171","msg":"trace[205437102] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d8gb2; range_end:; response_count:1; response_revision:10128; }","duration":"362.436142ms","start":"2026-04-15T07:50:45.900409Z","end":"2026-04-15T07:50:46.262845Z","steps":["trace[205437102] 'agreement among raft nodes before linearized reading' (duration: 362.201195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:50:46.262998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:50:45.900401Z","time spent":"362.584995ms","remote":"127.0.0.1:56468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-d8gb2\" "} {"level":"warn","ts":"2026-04-15T07:50:46.262581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:50:45.892979Z","time spent":"369.551425ms","remote":"127.0.0.1:56520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:50:46.262727Z","caller":"traceutil/trace.go:171","msg":"trace[313866309] transaction","detail":"{read_only:false; response_revision:10127; number_of_response:1; }","duration":"439.739089ms","start":"2026-04-15T07:50:45.822959Z","end":"2026-04-15T07:50:46.262698Z","steps":["trace[313866309] 'process raft request' (duration: 438.776223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:50:46.264441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:50:45.822932Z","time spent":"441.324152ms","remote":"127.0.0.1:56520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:51:51.040438Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8264} {"level":"info","ts":"2026-04-15T07:51:51.124909Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8264,"took":"81.015068ms","hash":205616382,"current-db-size-bytes":57274368,"current-db-size":"57 MB","current-db-size-in-use-bytes":24928256,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-15T07:51:51.12501Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":205616382,"revision":8264,"compact-revision":6055} {"level":"info","ts":"2026-04-15T07:53:21.409403Z","caller":"traceutil/trace.go:171","msg":"trace[1014591461] transaction","detail":"{read_only:false; response_revision:11083; number_of_response:1; }","duration":"109.020222ms","start":"2026-04-15T07:53:21.300348Z","end":"2026-04-15T07:53:21.409368Z","steps":["trace[1014591461] 'process raft request' (duration: 108.698374ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:56:51.046822Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10505} {"level":"info","ts":"2026-04-15T07:56:51.131533Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10505,"took":"82.611442ms","hash":2053943377,"current-db-size-bytes":57274368,"current-db-size":"57 MB","current-db-size-in-use-bytes":21340160,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-15T07:56:51.13164Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2053943377,"revision":10505,"compact-revision":8264}