{"level":"warn","ts":"2026-04-20T14:07:55.339509Z","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-20T14:07:55.339594Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.61: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.61:2380","--initial-cluster=instance=https://199.19.213.61:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.61:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.61: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-20T14:07:55.339654Z","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-20T14:07:55.339665Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.61:2380"]} {"level":"info","ts":"2026-04-20T14:07:55.339686Z","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-20T14:07:55.340378Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.61:2379"]} {"level":"info","ts":"2026-04-20T14:07:55.34045Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.61:2380"],"listen-peer-urls":["https://199.19.213.61:2380"],"advertise-client-urls":["https://199.19.213.61:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.61:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.61: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-20T14:07:55.344021Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.357079ms"} {"level":"info","ts":"2026-04-20T14:07:55.351742Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d1484a2210d3c2b8","cluster-id":"27fc2dec3fac595c"} {"level":"info","ts":"2026-04-20T14:07:55.351804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T14:07:55.351824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became follower at term 0"} {"level":"info","ts":"2026-04-20T14:07:55.35184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d1484a2210d3c2b8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T14:07:55.35186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became follower at term 1"} {"level":"info","ts":"2026-04-20T14:07:55.3519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 switched to configuration voters=(15080384862421762744)"} {"level":"warn","ts":"2026-04-20T14:07:55.357712Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T14:07:55.358988Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T14:07:55.36008Z","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-20T14:07:55.362169Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d1484a2210d3c2b8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T14:07:55.362473Z","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-20T14:07:55.36258Z","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-20T14:07:55.368313Z","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-20T14:07:55.362527Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d1484a2210d3c2b8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T14:07:55.369693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 switched to configuration voters=(15080384862421762744)"} {"level":"info","ts":"2026-04-20T14:07:55.369874Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"27fc2dec3fac595c","local-member-id":"d1484a2210d3c2b8","added-peer-id":"d1484a2210d3c2b8","added-peer-peer-urls":["https://199.19.213.61:2380"]} {"level":"info","ts":"2026-04-20T14:07:55.373675Z","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-20T14:07:55.373909Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.61:2380"} {"level":"info","ts":"2026-04-20T14:07:55.373977Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.61:2380"} {"level":"info","ts":"2026-04-20T14:07:55.374278Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d1484a2210d3c2b8","initial-advertise-peer-urls":["https://199.19.213.61:2380"],"listen-peer-urls":["https://199.19.213.61:2380"],"advertise-client-urls":["https://199.19.213.61:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.61:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T14:07:55.374352Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T14:07:56.052888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T14:07:56.052974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T14:07:56.053022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 received MsgPreVoteResp from d1484a2210d3c2b8 at term 1"} {"level":"info","ts":"2026-04-20T14:07:56.053042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became candidate at term 2"} {"level":"info","ts":"2026-04-20T14:07:56.05305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 received MsgVoteResp from d1484a2210d3c2b8 at term 2"} {"level":"info","ts":"2026-04-20T14:07:56.053066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became leader at term 2"} {"level":"info","ts":"2026-04-20T14:07:56.053078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d1484a2210d3c2b8 elected leader d1484a2210d3c2b8 at term 2"} {"level":"info","ts":"2026-04-20T14:07:56.056376Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d1484a2210d3c2b8","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.61:2379]}","request-path":"/0/members/d1484a2210d3c2b8/attributes","cluster-id":"27fc2dec3fac595c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T14:07:56.05638Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:07:56.056576Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T14:07:56.056633Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T14:07:56.056913Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T14:07:56.056948Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T14:07:56.058799Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"27fc2dec3fac595c","local-member-id":"d1484a2210d3c2b8","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:07:56.058903Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:07:56.058941Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:07:56.060106Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T14:07:56.064692Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.61:2379"} {"level":"info","ts":"2026-04-20T14:07:57.543338Z","caller":"traceutil/trace.go:171","msg":"trace[1932543427] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"180.91239ms","start":"2026-04-20T14:07:57.362404Z","end":"2026-04-20T14:07:57.543316Z","steps":["trace[1932543427] 'process raft request' (duration: 180.74346ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:07:57.574436Z","caller":"traceutil/trace.go:171","msg":"trace[2041037640] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"134.763646ms","start":"2026-04-20T14:07:57.439612Z","end":"2026-04-20T14:07:57.574376Z","steps":["trace[2041037640] 'process raft request' (duration: 134.640986ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:07:57.574654Z","caller":"traceutil/trace.go:171","msg":"trace[1703540059] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"134.916447ms","start":"2026-04-20T14:07:57.439725Z","end":"2026-04-20T14:07:57.574642Z","steps":["trace[1703540059] 'process raft request' (duration: 134.563636ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:07:57.57465Z","caller":"traceutil/trace.go:171","msg":"trace[850208248] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"207.480657ms","start":"2026-04-20T14:07:57.367153Z","end":"2026-04-20T14:07:57.574633Z","steps":["trace[850208248] 'read index received' (duration: 176.210528ms)","trace[850208248] 'applied index is now lower than readState.Index' (duration: 31.269309ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:07:57.574751Z","caller":"traceutil/trace.go:171","msg":"trace[1240374198] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"134.973848ms","start":"2026-04-20T14:07:57.439771Z","end":"2026-04-20T14:07:57.574745Z","steps":["trace[1240374198] 'process raft request' (duration: 134.552646ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:07:57.574772Z","caller":"traceutil/trace.go:171","msg":"trace[12604615] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"120.737861ms","start":"2026-04-20T14:07:57.454022Z","end":"2026-04-20T14:07:57.57476Z","steps":["trace[12604615] 'process raft request' (duration: 120.51871ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:07:57.57481Z","caller":"traceutil/trace.go:171","msg":"trace[76338575] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"134.934278ms","start":"2026-04-20T14:07:57.43987Z","end":"2026-04-20T14:07:57.574805Z","steps":["trace[76338575] 'process raft request' (duration: 134.484396ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:07:57.574504Z","caller":"traceutil/trace.go:171","msg":"trace[884142152] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"211.698168ms","start":"2026-04-20T14:07:57.362787Z","end":"2026-04-20T14:07:57.574485Z","steps":["trace[884142152] 'process raft request' (duration: 210.320134ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:07:57.574961Z","caller":"traceutil/trace.go:171","msg":"trace[2042981790] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"112.006179ms","start":"2026-04-20T14:07:57.462945Z","end":"2026-04-20T14:07:57.574951Z","steps":["trace[2042981790] 'process raft request' (duration: 111.649448ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:07:57.575104Z","caller":"traceutil/trace.go:171","msg":"trace[881174169] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"135.077948ms","start":"2026-04-20T14:07:57.439894Z","end":"2026-04-20T14:07:57.574971Z","steps":["trace[881174169] 'process raft request' (duration: 134.500726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:07:57.575178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.982999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T14:07:57.57524Z","caller":"traceutil/trace.go:171","msg":"trace[376184720] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"208.090669ms","start":"2026-04-20T14:07:57.367136Z","end":"2026-04-20T14:07:57.575227Z","steps":["trace[376184720] 'agreement among raft nodes before linearized reading' (duration: 207.957328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:07:57.575378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.948654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T14:07:57.5755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.193177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T14:07:57.575544Z","caller":"traceutil/trace.go:171","msg":"trace[712994751] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"135.238147ms","start":"2026-04-20T14:07:57.440295Z","end":"2026-04-20T14:07:57.575533Z","steps":["trace[712994751] 'agreement among raft nodes before linearized reading' (duration: 135.173907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:07:57.575647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.909514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.61\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T14:07:57.575759Z","caller":"traceutil/trace.go:171","msg":"trace[385460538] range","detail":"{range_begin:/registry/masterleases/199.19.213.61; range_end:; response_count:0; response_revision:11; }","duration":"138.074544ms","start":"2026-04-20T14:07:57.437669Z","end":"2026-04-20T14:07:57.575744Z","steps":["trace[385460538] 'agreement among raft nodes before linearized reading' (duration: 137.822833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:07:57.575882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.406375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T14:07:57.575923Z","caller":"traceutil/trace.go:171","msg":"trace[1787259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"206.455425ms","start":"2026-04-20T14:07:57.369459Z","end":"2026-04-20T14:07:57.575914Z","steps":["trace[1787259] 'agreement among raft nodes before linearized reading' (duration: 206.396365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:07:57.576209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.160719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T14:07:57.576325Z","caller":"traceutil/trace.go:171","msg":"trace[1737122769] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"136.315859ms","start":"2026-04-20T14:07:57.439998Z","end":"2026-04-20T14:07:57.576314Z","steps":["trace[1737122769] 'agreement among raft nodes before linearized reading' (duration: 136.164839ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:07:57.577119Z","caller":"traceutil/trace.go:171","msg":"trace[212655091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"207.693128ms","start":"2026-04-20T14:07:57.369404Z","end":"2026-04-20T14:07:57.577097Z","steps":["trace[212655091] 'agreement among raft nodes before linearized reading' (duration: 205.922014ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:07:57.575124Z","caller":"traceutil/trace.go:171","msg":"trace[1604311911] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"135.092438ms","start":"2026-04-20T14:07:57.439937Z","end":"2026-04-20T14:07:57.57503Z","steps":["trace[1604311911] 'process raft request' (duration: 134.547917ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:08:20.015931Z","caller":"traceutil/trace.go:171","msg":"trace[1080433436] linearizableReadLoop","detail":"{readStateIndex:478; appliedIndex:477; }","duration":"143.53373ms","start":"2026-04-20T14:08:19.87237Z","end":"2026-04-20T14:08:20.015904Z","steps":["trace[1080433436] 'read index received' (duration: 143.326159ms)","trace[1080433436] 'applied index is now lower than readState.Index' (duration: 206.711µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:08:20.016051Z","caller":"traceutil/trace.go:171","msg":"trace[501047413] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"154.636552ms","start":"2026-04-20T14:08:19.86138Z","end":"2026-04-20T14:08:20.016016Z","steps":["trace[501047413] 'process raft request' (duration: 154.389039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:08:20.016237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.859718ms","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-20T14:08:20.016287Z","caller":"traceutil/trace.go:171","msg":"trace[761323388] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:458; }","duration":"143.983836ms","start":"2026-04-20T14:08:19.872287Z","end":"2026-04-20T14:08:20.01627Z","steps":["trace[761323388] 'agreement among raft nodes before linearized reading' (duration: 143.746662ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:08:21.211067Z","caller":"traceutil/trace.go:171","msg":"trace[1154180071] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"100.252857ms","start":"2026-04-20T14:08:21.110772Z","end":"2026-04-20T14:08:21.211025Z","steps":["trace[1154180071] 'process raft request' (duration: 99.917629ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:08:26.301551Z","caller":"traceutil/trace.go:171","msg":"trace[1022959644] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"247.316473ms","start":"2026-04-20T14:08:26.054201Z","end":"2026-04-20T14:08:26.301517Z","steps":["trace[1022959644] 'read index received' (duration: 246.350446ms)","trace[1022959644] 'applied index is now lower than readState.Index' (duration: 964.857µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:08:26.301648Z","caller":"traceutil/trace.go:171","msg":"trace[568109164] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"265.84204ms","start":"2026-04-20T14:08:26.035751Z","end":"2026-04-20T14:08:26.301593Z","steps":["trace[568109164] 'process raft request' (duration: 265.069962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:08:26.301832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.610928ms","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-04-20T14:08:26.301884Z","caller":"traceutil/trace.go:171","msg":"trace[1778128791] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:555; }","duration":"247.720414ms","start":"2026-04-20T14:08:26.054148Z","end":"2026-04-20T14:08:26.301869Z","steps":["trace[1778128791] 'agreement among raft nodes before linearized reading' (duration: 247.543775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:08:26.302059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.293251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qgg4g\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-20T14:08:26.302071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.688463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-20T14:08:26.302191Z","caller":"traceutil/trace.go:171","msg":"trace[1433226790] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qgg4g; range_end:; response_count:1; response_revision:555; }","duration":"230.534553ms","start":"2026-04-20T14:08:26.071633Z","end":"2026-04-20T14:08:26.302168Z","steps":["trace[1433226790] 'agreement among raft nodes before linearized reading' (duration: 230.25566ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:08:26.302207Z","caller":"traceutil/trace.go:171","msg":"trace[1581398398] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:555; }","duration":"244.861962ms","start":"2026-04-20T14:08:26.057317Z","end":"2026-04-20T14:08:26.302179Z","steps":["trace[1581398398] 'agreement among raft nodes before linearized reading' (duration: 244.529885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:08:44.054146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.036826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:08:44.05424Z","caller":"traceutil/trace.go:171","msg":"trace[2071104369] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:733; }","duration":"108.192923ms","start":"2026-04-20T14:08:43.946028Z","end":"2026-04-20T14:08:44.054221Z","steps":["trace[2071104369] 'range keys from in-memory index tree' (duration: 107.782135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:08:44.054239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.561508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T14:08:44.05434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.095069ms","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-20T14:08:44.05488Z","caller":"traceutil/trace.go:171","msg":"trace[811158839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:733; }","duration":"160.681162ms","start":"2026-04-20T14:08:43.894146Z","end":"2026-04-20T14:08:44.054827Z","steps":["trace[811158839] 'range keys from in-memory index tree' (duration: 159.833229ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:08:44.055424Z","caller":"traceutil/trace.go:171","msg":"trace[1454770389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:733; }","duration":"161.806977ms","start":"2026-04-20T14:08:43.893572Z","end":"2026-04-20T14:08:44.055379Z","steps":["trace[1454770389] 'range keys from in-memory index tree' (duration: 160.291127ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:08:44.171715Z","caller":"traceutil/trace.go:171","msg":"trace[759593156] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"111.157792ms","start":"2026-04-20T14:08:44.060525Z","end":"2026-04-20T14:08:44.171682Z","steps":["trace[759593156] 'process raft request' (duration: 109.58776ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:12:00.899796Z","caller":"traceutil/trace.go:171","msg":"trace[583186674] transaction","detail":"{read_only:false; response_revision:2505; number_of_response:1; }","duration":"124.836035ms","start":"2026-04-20T14:12:00.774909Z","end":"2026-04-20T14:12:00.899745Z","steps":["trace[583186674] 'process raft request' (duration: 124.593232ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:13:21.385158Z","caller":"traceutil/trace.go:171","msg":"trace[372922479] transaction","detail":"{read_only:false; response_revision:3015; number_of_response:1; }","duration":"157.771176ms","start":"2026-04-20T14:13:21.227117Z","end":"2026-04-20T14:13:21.384888Z","steps":["trace[372922479] 'process raft request' (duration: 152.865164ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:13:55.626907Z","caller":"traceutil/trace.go:171","msg":"trace[695767810] transaction","detail":"{read_only:false; response_revision:3204; number_of_response:1; }","duration":"104.453805ms","start":"2026-04-20T14:13:55.522418Z","end":"2026-04-20T14:13:55.626872Z","steps":["trace[695767810] 'process raft request' (duration: 104.299112ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:15:49.198118Z","caller":"traceutil/trace.go:171","msg":"trace[726906326] transaction","detail":"{read_only:false; response_revision:3878; number_of_response:1; }","duration":"147.252386ms","start":"2026-04-20T14:15:49.050835Z","end":"2026-04-20T14:15:49.198088Z","steps":["trace[726906326] 'process raft request' (duration: 106.348803ms)","trace[726906326] 'compare' (duration: 40.70071ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:15:49.198492Z","caller":"traceutil/trace.go:171","msg":"trace[1252994700] transaction","detail":"{read_only:false; response_revision:3879; number_of_response:1; }","duration":"147.541311ms","start":"2026-04-20T14:15:49.050914Z","end":"2026-04-20T14:15:49.198455Z","steps":["trace[1252994700] 'process raft request' (duration: 147.129334ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:17:49.189913Z","caller":"traceutil/trace.go:171","msg":"trace[156697688] linearizableReadLoop","detail":"{readStateIndex:5719; appliedIndex:5718; }","duration":"133.84708ms","start":"2026-04-20T14:17:49.056036Z","end":"2026-04-20T14:17:49.189883Z","steps":["trace[156697688] 'read index received' (duration: 83.7298ms)","trace[156697688] 'applied index is now lower than readState.Index' (duration: 50.1165ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:17:49.189979Z","caller":"traceutil/trace.go:171","msg":"trace[1595431900] transaction","detail":"{read_only:false; response_revision:5509; number_of_response:1; }","duration":"136.2777ms","start":"2026-04-20T14:17:49.053664Z","end":"2026-04-20T14:17:49.189942Z","steps":["trace[1595431900] 'process raft request' (duration: 85.843096ms)","trace[1595431900] 'compare' (duration: 50.258952ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:17:49.190163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.107093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-04-20T14:17:49.190196Z","caller":"traceutil/trace.go:171","msg":"trace[639345532] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:5509; }","duration":"134.191684ms","start":"2026-04-20T14:17:49.055995Z","end":"2026-04-20T14:17:49.190187Z","steps":["trace[639345532] 'agreement among raft nodes before linearized reading' (duration: 134.032232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:17:49.19022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.931505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-20T14:17:49.190281Z","caller":"traceutil/trace.go:171","msg":"trace[1618414126] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5509; }","duration":"113.034006ms","start":"2026-04-20T14:17:49.077228Z","end":"2026-04-20T14:17:49.190262Z","steps":["trace[1618414126] 'agreement among raft nodes before linearized reading' (duration: 112.833083ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:17:56.08785Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2825} {"level":"info","ts":"2026-04-20T14:17:56.360953Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2825,"took":"271.644816ms","hash":4184886797,"current-db-size-bytes":54132736,"current-db-size":"54 MB","current-db-size-in-use-bytes":30867456,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-20T14:17:56.361059Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4184886797,"revision":2825,"compact-revision":-1}