{"level":"warn","ts":"2026-05-05T02:22:31.109789Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T02:22:31.109887Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.169: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.169:2380","--initial-cluster=instance=https://199.19.213.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.169:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-05T02:22:31.109988Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T02:22:31.110003Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.169:2380"]} {"level":"info","ts":"2026-05-05T02:22:31.110021Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-05T02:22:31.110701Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.169:2379"]} {"level":"info","ts":"2026-05-05T02:22:31.110779Z","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.169:2380"],"listen-peer-urls":["https://199.19.213.169:2380"],"advertise-client-urls":["https://199.19.213.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.169:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-05T02:22:31.115677Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.693615ms"} {"level":"info","ts":"2026-05-05T02:22:31.123791Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a742f9f5aa7326e5","cluster-id":"a6b466adbadbbcd5"} {"level":"info","ts":"2026-05-05T02:22:31.123879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T02:22:31.123938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 became follower at term 0"} {"level":"info","ts":"2026-05-05T02:22:31.123953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a742f9f5aa7326e5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T02:22:31.123962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 became follower at term 1"} {"level":"info","ts":"2026-05-05T02:22:31.12403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 switched to configuration voters=(12052470386318845669)"} {"level":"warn","ts":"2026-05-05T02:22:31.130652Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T02:22:31.131975Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T02:22:31.133188Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-05T02:22:31.136609Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a742f9f5aa7326e5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T02:22:31.136812Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T02:22:31.136901Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T02:22:31.136944Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T02:22:31.137068Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a742f9f5aa7326e5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T02:22:31.138463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 switched to configuration voters=(12052470386318845669)"} {"level":"info","ts":"2026-05-05T02:22:31.138591Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a6b466adbadbbcd5","local-member-id":"a742f9f5aa7326e5","added-peer-id":"a742f9f5aa7326e5","added-peer-peer-urls":["https://199.19.213.169:2380"]} {"level":"info","ts":"2026-05-05T02:22:31.140849Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-05T02:22:31.14109Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a742f9f5aa7326e5","initial-advertise-peer-urls":["https://199.19.213.169:2380"],"listen-peer-urls":["https://199.19.213.169:2380"],"advertise-client-urls":["https://199.19.213.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T02:22:31.141125Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T02:22:31.141412Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.169:2380"} {"level":"info","ts":"2026-05-05T02:22:31.141443Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.169:2380"} {"level":"info","ts":"2026-05-05T02:22:31.624378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T02:22:31.624422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T02:22:31.624455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 received MsgPreVoteResp from a742f9f5aa7326e5 at term 1"} {"level":"info","ts":"2026-05-05T02:22:31.624469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 became candidate at term 2"} {"level":"info","ts":"2026-05-05T02:22:31.624476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 received MsgVoteResp from a742f9f5aa7326e5 at term 2"} {"level":"info","ts":"2026-05-05T02:22:31.624487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 became leader at term 2"} {"level":"info","ts":"2026-05-05T02:22:31.624498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a742f9f5aa7326e5 elected leader a742f9f5aa7326e5 at term 2"} {"level":"info","ts":"2026-05-05T02:22:31.627353Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a742f9f5aa7326e5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.169:2379]}","request-path":"/0/members/a742f9f5aa7326e5/attributes","cluster-id":"a6b466adbadbbcd5","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T02:22:31.627367Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T02:22:31.627488Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T02:22:31.62767Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T02:22:31.628024Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T02:22:31.628458Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T02:22:31.628752Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a6b466adbadbbcd5","local-member-id":"a742f9f5aa7326e5","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T02:22:31.62898Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T02:22:31.629142Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T02:22:31.631529Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.169:2379"} {"level":"info","ts":"2026-05-05T02:22:31.646678Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-05T02:22:41.11204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.76196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-nrqzn\" ","response":"range_response_count:1 size:4466"} {"level":"info","ts":"2026-05-05T02:22:41.112139Z","caller":"traceutil/trace.go:171","msg":"trace[455557828] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-nrqzn; range_end:; response_count:1; response_revision:384; }","duration":"104.899254ms","start":"2026-05-05T02:22:41.007221Z","end":"2026-05-05T02:22:41.112121Z","steps":["trace[455557828] 'range keys from in-memory index tree' (duration: 104.682599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:22:49.144415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.994849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-05-05T02:22:49.144495Z","caller":"traceutil/trace.go:171","msg":"trace[1390805990] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:441; }","duration":"311.125191ms","start":"2026-05-05T02:22:48.833357Z","end":"2026-05-05T02:22:49.144482Z","steps":["trace[1390805990] 'range keys from in-memory index tree' (duration: 310.909007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:22:49.144521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T02:22:48.833337Z","time spent":"311.178743ms","remote":"127.0.0.1:43148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4350,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-05-05T02:22:49.359285Z","caller":"traceutil/trace.go:171","msg":"trace[255092282] linearizableReadLoop","detail":"{readStateIndex:455; appliedIndex:454; }","duration":"205.970369ms","start":"2026-05-05T02:22:49.15329Z","end":"2026-05-05T02:22:49.35926Z","steps":["trace[255092282] 'read index received' (duration: 205.821846ms)","trace[255092282] 'applied index is now lower than readState.Index' (duration: 147.473µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T02:22:49.359405Z","caller":"traceutil/trace.go:171","msg":"trace[844536023] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"207.794977ms","start":"2026-05-05T02:22:49.151575Z","end":"2026-05-05T02:22:49.35937Z","steps":["trace[844536023] 'process raft request' (duration: 207.533342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:22:49.359475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.180589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-05T02:22:49.359512Z","caller":"traceutil/trace.go:171","msg":"trace[1624530098] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:442; }","duration":"199.268351ms","start":"2026-05-05T02:22:49.160232Z","end":"2026-05-05T02:22:49.3595Z","steps":["trace[1624530098] 'agreement among raft nodes before linearized reading' (duration: 199.169809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:22:49.359483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.160283ms","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-05-05T02:22:49.359838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.714783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-05T02:22:49.360055Z","caller":"traceutil/trace.go:171","msg":"trace[1823696605] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:442; }","duration":"157.258594ms","start":"2026-05-05T02:22:49.202772Z","end":"2026-05-05T02:22:49.36003Z","steps":["trace[1823696605] 'agreement among raft nodes before linearized reading' (duration: 156.687662ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:22:49.360404Z","caller":"traceutil/trace.go:171","msg":"trace[1104512844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:442; }","duration":"207.114863ms","start":"2026-05-05T02:22:49.153261Z","end":"2026-05-05T02:22:49.360376Z","steps":["trace[1104512844] 'agreement among raft nodes before linearized reading' (duration: 206.117992ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.079004Z","caller":"traceutil/trace.go:171","msg":"trace[2011324846] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"117.966056ms","start":"2026-05-05T02:22:59.961015Z","end":"2026-05-05T02:23:00.078981Z","steps":["trace[2011324846] 'process raft request' (duration: 117.809583ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.085736Z","caller":"traceutil/trace.go:171","msg":"trace[363703802] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"121.872049ms","start":"2026-05-05T02:22:59.963839Z","end":"2026-05-05T02:23:00.085711Z","steps":["trace[363703802] 'process raft request' (duration: 121.672695ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.085883Z","caller":"traceutil/trace.go:171","msg":"trace[1613817380] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"104.183534ms","start":"2026-05-05T02:22:59.981679Z","end":"2026-05-05T02:23:00.085863Z","steps":["trace[1613817380] 'process raft request' (duration: 104.126753ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.086087Z","caller":"traceutil/trace.go:171","msg":"trace[260575165] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"124.566329ms","start":"2026-05-05T02:22:59.961508Z","end":"2026-05-05T02:23:00.086074Z","steps":["trace[260575165] 'process raft request' (duration: 123.818785ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.086201Z","caller":"traceutil/trace.go:171","msg":"trace[1920195616] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"117.699519ms","start":"2026-05-05T02:22:59.968493Z","end":"2026-05-05T02:23:00.086192Z","steps":["trace[1920195616] 'process raft request' (duration: 117.044607ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.086271Z","caller":"traceutil/trace.go:171","msg":"trace[317787637] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"114.029721ms","start":"2026-05-05T02:22:59.972234Z","end":"2026-05-05T02:23:00.086264Z","steps":["trace[317787637] 'process raft request' (duration: 113.341288ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.086324Z","caller":"traceutil/trace.go:171","msg":"trace[616213035] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"113.97692ms","start":"2026-05-05T02:22:59.972342Z","end":"2026-05-05T02:23:00.086319Z","steps":["trace[616213035] 'process raft request' (duration: 113.275447ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.086374Z","caller":"traceutil/trace.go:171","msg":"trace[2066719204] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"113.944239ms","start":"2026-05-05T02:22:59.972425Z","end":"2026-05-05T02:23:00.08637Z","steps":["trace[2066719204] 'process raft request' (duration: 113.228646ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.086422Z","caller":"traceutil/trace.go:171","msg":"trace[2120872427] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"113.321088ms","start":"2026-05-05T02:22:59.973096Z","end":"2026-05-05T02:23:00.086417Z","steps":["trace[2120872427] 'process raft request' (duration: 112.602384ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.086516Z","caller":"traceutil/trace.go:171","msg":"trace[444252646] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"122.728824ms","start":"2026-05-05T02:22:59.963782Z","end":"2026-05-05T02:23:00.086511Z","steps":["trace[444252646] 'process raft request' (duration: 121.699775ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.086693Z","caller":"traceutil/trace.go:171","msg":"trace[1026898239] transaction","detail":"{read_only:false; number_of_response:1; response_revision:520; }","duration":"125.12133ms","start":"2026-05-05T02:22:59.961565Z","end":"2026-05-05T02:23:00.086687Z","steps":["trace[1026898239] 'process raft request' (duration: 123.873917ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.489723Z","caller":"traceutil/trace.go:171","msg":"trace[686522679] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"111.180062ms","start":"2026-05-05T02:23:00.378512Z","end":"2026-05-05T02:23:00.489693Z","steps":["trace[686522679] 'process raft request' (duration: 111.124231ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:00.489946Z","caller":"traceutil/trace.go:171","msg":"trace[1548124646] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"164.535371ms","start":"2026-05-05T02:23:00.325391Z","end":"2026-05-05T02:23:00.489926Z","steps":["trace[1548124646] 'process raft request' (duration: 115.946112ms)","trace[1548124646] 'compare' (duration: 47.947608ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T02:23:00.490016Z","caller":"traceutil/trace.go:171","msg":"trace[910086212] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"135.629679ms","start":"2026-05-05T02:23:00.354348Z","end":"2026-05-05T02:23:00.489978Z","steps":["trace[910086212] 'process raft request' (duration: 135.203192ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:23:06.611231Z","caller":"traceutil/trace.go:171","msg":"trace[514229980] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"483.104097ms","start":"2026-05-05T02:23:06.128104Z","end":"2026-05-05T02:23:06.611208Z","steps":["trace[514229980] 'process raft request' (duration: 482.924684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:23:06.612154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T02:23:06.127907Z","time spent":"483.470334ms","remote":"127.0.0.1:43148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T02:23:06.686624Z","caller":"traceutil/trace.go:171","msg":"trace[815270191] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"510.131989ms","start":"2026-05-05T02:23:06.176453Z","end":"2026-05-05T02:23:06.686585Z","steps":["trace[815270191] 'process raft request' (duration: 509.975076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:23:06.686764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T02:23:06.176125Z","time spent":"510.578017ms","remote":"127.0.0.1:43462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T02:23:07.222272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.759728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T02:23:07.222357Z","caller":"traceutil/trace.go:171","msg":"trace[1362997965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"492.89625ms","start":"2026-05-05T02:23:06.729444Z","end":"2026-05-05T02:23:07.22234Z","steps":["trace[1362997965] 'range keys from in-memory index tree' (duration: 492.659717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:23:07.2224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T02:23:06.729423Z","time spent":"492.968631ms","remote":"127.0.0.1:42918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T02:23:07.222677Z","caller":"traceutil/trace.go:171","msg":"trace[1628388099] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"254.105675ms","start":"2026-05-05T02:23:06.968543Z","end":"2026-05-05T02:23:07.222649Z","steps":["trace[1628388099] 'process raft request' (duration: 218.679149ms)","trace[1628388099] 'compare' (duration: 34.903007ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T02:23:07.2227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.032268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T02:23:07.2228Z","caller":"traceutil/trace.go:171","msg":"trace[577773144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"440.225912ms","start":"2026-05-05T02:23:06.782552Z","end":"2026-05-05T02:23:07.222778Z","steps":["trace[577773144] 'range keys from in-memory index tree' (duration: 439.809265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:23:07.222848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T02:23:06.782532Z","time spent":"440.307053ms","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T02:23:07.224514Z","caller":"traceutil/trace.go:171","msg":"trace[1138613078] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"131.765019ms","start":"2026-05-05T02:23:07.092727Z","end":"2026-05-05T02:23:07.224492Z","steps":["trace[1138613078] 'process raft request' (duration: 131.093457ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:23:32.295531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.516936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T02:23:32.295599Z","caller":"traceutil/trace.go:171","msg":"trace[353879700] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"143.628817ms","start":"2026-05-05T02:23:32.151958Z","end":"2026-05-05T02:23:32.295586Z","steps":["trace[353879700] 'range keys from in-memory index tree' (duration: 143.437865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:23:32.295581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.863159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-frtnt\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-05T02:23:32.295682Z","caller":"traceutil/trace.go:171","msg":"trace[767317919] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-frtnt; range_end:; response_count:1; response_revision:803; }","duration":"114.01902ms","start":"2026-05-05T02:23:32.18164Z","end":"2026-05-05T02:23:32.295659Z","steps":["trace[767317919] 'range keys from in-memory index tree' (duration: 113.670356ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:24:48.211355Z","caller":"traceutil/trace.go:171","msg":"trace[1349027590] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1933; }","duration":"272.891794ms","start":"2026-05-05T02:24:47.938425Z","end":"2026-05-05T02:24:48.211317Z","steps":["trace[1349027590] 'read index received' (duration: 272.621391ms)","trace[1349027590] 'applied index is now lower than readState.Index' (duration: 268.973µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T02:24:48.211442Z","caller":"traceutil/trace.go:171","msg":"trace[1875171711] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"305.77515ms","start":"2026-05-05T02:24:47.905627Z","end":"2026-05-05T02:24:48.211403Z","steps":["trace[1875171711] 'process raft request' (duration: 305.416816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:24:48.211655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.202397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-05T02:24:48.211686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T02:24:47.905597Z","time spent":"305.943012ms","remote":"127.0.0.1:43212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T02:24:48.211749Z","caller":"traceutil/trace.go:171","msg":"trace[1494396626] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1863; }","duration":"273.36504ms","start":"2026-05-05T02:24:47.938362Z","end":"2026-05-05T02:24:48.211727Z","steps":["trace[1494396626] 'agreement among raft nodes before linearized reading' (duration: 273.164667ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:24:48.211872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.324042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-05T02:24:48.21197Z","caller":"traceutil/trace.go:171","msg":"trace[1905467374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1863; }","duration":"160.474334ms","start":"2026-05-05T02:24:48.051476Z","end":"2026-05-05T02:24:48.21195Z","steps":["trace[1905467374] 'agreement among raft nodes before linearized reading' (duration: 160.273152ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:24:48.211872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.789137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-05T02:24:48.212139Z","caller":"traceutil/trace.go:171","msg":"trace[1840985615] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1863; }","duration":"160.12257ms","start":"2026-05-05T02:24:48.051996Z","end":"2026-05-05T02:24:48.212119Z","steps":["trace[1840985615] 'agreement among raft nodes before linearized reading' (duration: 159.719185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:24:48.212224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.581977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-05T02:24:48.212426Z","caller":"traceutil/trace.go:171","msg":"trace[14416092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1863; }","duration":"163.820319ms","start":"2026-05-05T02:24:48.048586Z","end":"2026-05-05T02:24:48.212406Z","steps":["trace[14416092] 'agreement among raft nodes before linearized reading' (duration: 163.03035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:24:48.605425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.568274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b0054db-2658-4163-9ff6-b8e9eeb17d24\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-05T02:24:48.605629Z","caller":"traceutil/trace.go:171","msg":"trace[1622499081] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4b0054db-2658-4163-9ff6-b8e9eeb17d24; range_end:; response_count:1; response_revision:1866; }","duration":"140.785466ms","start":"2026-05-05T02:24:48.464809Z","end":"2026-05-05T02:24:48.605595Z","steps":["trace[1622499081] 'range keys from in-memory index tree' (duration: 140.368633ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:25:01.130757Z","caller":"traceutil/trace.go:171","msg":"trace[935544245] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"136.644787ms","start":"2026-05-05T02:25:00.994086Z","end":"2026-05-05T02:25:01.130731Z","steps":["trace[935544245] 'process raft request' (duration: 136.467415ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:25:23.338704Z","caller":"traceutil/trace.go:171","msg":"trace[296079121] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"121.846485ms","start":"2026-05-05T02:25:23.216823Z","end":"2026-05-05T02:25:23.33867Z","steps":["trace[296079121] 'process raft request' (duration: 121.676093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:25:23.564025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.67781ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T02:25:23.564157Z","caller":"traceutil/trace.go:171","msg":"trace[284153297] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"146.522984ms","start":"2026-05-05T02:25:23.41761Z","end":"2026-05-05T02:25:23.564133Z","steps":["trace[284153297] 'process raft request' (duration: 14.48947ms)","trace[284153297] 'compare' (duration: 131.495719ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T02:25:24.527665Z","caller":"traceutil/trace.go:171","msg":"trace[249482262] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"111.681124ms","start":"2026-05-05T02:25:24.415908Z","end":"2026-05-05T02:25:24.527589Z","steps":["trace[249482262] 'process raft request' (duration: 13.519452ms)","trace[249482262] 'compare' (duration: 97.867939ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T02:25:24.527807Z","caller":"traceutil/trace.go:171","msg":"trace[772974477] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"111.673553ms","start":"2026-05-05T02:25:24.416098Z","end":"2026-05-05T02:25:24.527771Z","steps":["trace[772974477] 'process raft request' (duration: 111.390561ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:25:24.52782Z","caller":"traceutil/trace.go:171","msg":"trace[1748079274] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"111.118727ms","start":"2026-05-05T02:25:24.416681Z","end":"2026-05-05T02:25:24.5278Z","steps":["trace[1748079274] 'process raft request' (duration: 110.867664ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:25:24.892608Z","caller":"traceutil/trace.go:171","msg":"trace[1083397835] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2200; }","duration":"181.430399ms","start":"2026-05-05T02:25:24.711155Z","end":"2026-05-05T02:25:24.892585Z","steps":["trace[1083397835] 'read index received' (duration: 103.350772ms)","trace[1083397835] 'applied index is now lower than readState.Index' (duration: 78.078697ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T02:25:24.8927Z","caller":"traceutil/trace.go:171","msg":"trace[102204813] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"276.796573ms","start":"2026-05-05T02:25:24.61586Z","end":"2026-05-05T02:25:24.892657Z","steps":["trace[102204813] 'process raft request' (duration: 198.639246ms)","trace[102204813] 'compare' (duration: 77.858354ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T02:25:24.892954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.379633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T02:25:24.893031Z","caller":"traceutil/trace.go:171","msg":"trace[1304470078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2122; }","duration":"167.480694ms","start":"2026-05-05T02:25:24.725523Z","end":"2026-05-05T02:25:24.893003Z","steps":["trace[1304470078] 'agreement among raft nodes before linearized reading' (duration: 167.286812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:25:24.893032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.863033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-05T02:25:24.893213Z","caller":"traceutil/trace.go:171","msg":"trace[362540744] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2122; }","duration":"182.040934ms","start":"2026-05-05T02:25:24.711098Z","end":"2026-05-05T02:25:24.893139Z","steps":["trace[362540744] 'agreement among raft nodes before linearized reading' (duration: 181.61226ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:27:08.090283Z","caller":"traceutil/trace.go:171","msg":"trace[70698193] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"127.908389ms","start":"2026-05-05T02:27:07.962345Z","end":"2026-05-05T02:27:08.090253Z","steps":["trace[70698193] 'process raft request' (duration: 127.718933ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:30:48.399879Z","caller":"traceutil/trace.go:171","msg":"trace[1598170224] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"119.330793ms","start":"2026-05-05T02:30:48.280523Z","end":"2026-05-05T02:30:48.399854Z","steps":["trace[1598170224] 'process raft request' (duration: 118.900966ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:30:48.627951Z","caller":"traceutil/trace.go:171","msg":"trace[1665107455] linearizableReadLoop","detail":"{readStateIndex:4897; appliedIndex:4896; }","duration":"221.17908ms","start":"2026-05-05T02:30:48.406753Z","end":"2026-05-05T02:30:48.627932Z","steps":["trace[1665107455] 'read index received' (duration: 178.161017ms)","trace[1665107455] 'applied index is now lower than readState.Index' (duration: 43.017343ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T02:30:48.628047Z","caller":"traceutil/trace.go:171","msg":"trace[1824271232] transaction","detail":"{read_only:false; response_revision:4724; number_of_response:1; }","duration":"221.574886ms","start":"2026-05-05T02:30:48.406464Z","end":"2026-05-05T02:30:48.628039Z","steps":["trace[1824271232] 'process raft request' (duration: 178.433821ms)","trace[1824271232] 'compare' (duration: 42.948252ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T02:30:48.628174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.409773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-dfd1cf46-8483-47ed-885b-22cdab07bbe4\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-05T02:30:48.628212Z","caller":"traceutil/trace.go:171","msg":"trace[1774264026] range","detail":"{range_begin:/registry/persistentvolumes/pvc-dfd1cf46-8483-47ed-885b-22cdab07bbe4; range_end:; response_count:1; response_revision:4724; }","duration":"221.591186ms","start":"2026-05-05T02:30:48.40661Z","end":"2026-05-05T02:30:48.628201Z","steps":["trace[1774264026] 'agreement among raft nodes before linearized reading' (duration: 221.475434ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:30:48.631261Z","caller":"traceutil/trace.go:171","msg":"trace[1146761358] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"113.455093ms","start":"2026-05-05T02:30:48.517796Z","end":"2026-05-05T02:30:48.631251Z","steps":["trace[1146761358] 'process raft request' (duration: 113.419972ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:30:48.631468Z","caller":"traceutil/trace.go:171","msg":"trace[1973361818] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"224.593581ms","start":"2026-05-05T02:30:48.406867Z","end":"2026-05-05T02:30:48.631461Z","steps":["trace[1973361818] 'process raft request' (duration: 224.234496ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:30:48.631631Z","caller":"traceutil/trace.go:171","msg":"trace[1166176024] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"223.903851ms","start":"2026-05-05T02:30:48.407721Z","end":"2026-05-05T02:30:48.631625Z","steps":["trace[1166176024] 'process raft request' (duration: 223.434334ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:30:48.631656Z","caller":"traceutil/trace.go:171","msg":"trace[493581239] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"223.855ms","start":"2026-05-05T02:30:48.407792Z","end":"2026-05-05T02:30:48.631647Z","steps":["trace[493581239] 'process raft request' (duration: 223.399583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:30:48.654611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.696654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-05-05T02:30:48.654694Z","caller":"traceutil/trace.go:171","msg":"trace[435289298] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4729; }","duration":"224.807376ms","start":"2026-05-05T02:30:48.429866Z","end":"2026-05-05T02:30:48.654673Z","steps":["trace[435289298] 'agreement among raft nodes before linearized reading' (duration: 224.554152ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:30:49.014817Z","caller":"traceutil/trace.go:171","msg":"trace[123420647] linearizableReadLoop","detail":"{readStateIndex:4903; appliedIndex:4902; }","duration":"147.270316ms","start":"2026-05-05T02:30:48.867515Z","end":"2026-05-05T02:30:49.014785Z","steps":["trace[123420647] 'read index received' (duration: 147.094443ms)","trace[123420647] 'applied index is now lower than readState.Index' (duration: 174.973µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T02:30:49.014946Z","caller":"traceutil/trace.go:171","msg":"trace[1910873705] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"149.752384ms","start":"2026-05-05T02:30:48.865162Z","end":"2026-05-05T02:30:49.014915Z","steps":["trace[1910873705] 'process raft request' (duration: 149.49621ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:30:49.015099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.57203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-822d86a2-33c3-4a63-a8d1-8dbe9953346f\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-05T02:30:49.01514Z","caller":"traceutil/trace.go:171","msg":"trace[298331436] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-822d86a2-33c3-4a63-a8d1-8dbe9953346f; range_end:; response_count:1; response_revision:4730; }","duration":"147.664972ms","start":"2026-05-05T02:30:48.867463Z","end":"2026-05-05T02:30:49.015128Z","steps":["trace[298331436] 'agreement among raft nodes before linearized reading' (duration: 147.418498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T02:31:01.697516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.864185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-05T02:31:01.697617Z","caller":"traceutil/trace.go:171","msg":"trace[2074201531] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4910; }","duration":"218.20148ms","start":"2026-05-05T02:31:01.479389Z","end":"2026-05-05T02:31:01.69759Z","steps":["trace[2074201531] 'range keys from in-memory index tree' (duration: 217.634921ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:31:01.900434Z","caller":"traceutil/trace.go:171","msg":"trace[63944007] linearizableReadLoop","detail":"{readStateIndex:5091; appliedIndex:5090; }","duration":"174.368068ms","start":"2026-05-05T02:31:01.726041Z","end":"2026-05-05T02:31:01.900409Z","steps":["trace[63944007] 'read index received' (duration: 137.943058ms)","trace[63944007] 'applied index is now lower than readState.Index' (duration: 36.42415ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T02:31:01.900627Z","caller":"traceutil/trace.go:171","msg":"trace[1719551726] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"198.479457ms","start":"2026-05-05T02:31:01.702123Z","end":"2026-05-05T02:31:01.900603Z","steps":["trace[1719551726] 'process raft request' (duration: 161.922604ms)","trace[1719551726] 'compare' (duration: 36.214138ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T02:31:01.900774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.708073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T02:31:01.901136Z","caller":"traceutil/trace.go:171","msg":"trace[1166380479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4912; }","duration":"175.114619ms","start":"2026-05-05T02:31:01.726001Z","end":"2026-05-05T02:31:01.901116Z","steps":["trace[1166380479] 'agreement among raft nodes before linearized reading' (duration: 174.50485ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T02:32:31.681195Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2908} {"level":"info","ts":"2026-05-05T02:32:31.763593Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2908,"took":"80.421803ms","hash":3132004656,"current-db-size-bytes":54468608,"current-db-size":"54 MB","current-db-size-in-use-bytes":29487104,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-05T02:32:31.76365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3132004656,"revision":2908,"compact-revision":-1} {"level":"info","ts":"2026-05-05T02:37:31.685796Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5636} {"level":"info","ts":"2026-05-05T02:37:31.791249Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5636,"took":"104.084313ms","hash":3690680235,"current-db-size-bytes":54468608,"current-db-size":"54 MB","current-db-size-in-use-bytes":18464768,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-05T02:37:31.791325Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3690680235,"revision":5636,"compact-revision":2908}