{"level":"warn","ts":"2026-04-07T01:24:25.236582Z","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-07T01:24:25.236689Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.221:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.221:2380","--initial-cluster=instance=https://162.253.55.221:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.221:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.221: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-07T01:24:25.236769Z","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-07T01:24:25.236791Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.221:2380"]} {"level":"info","ts":"2026-04-07T01:24:25.236821Z","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-07T01:24:25.237668Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.221:2379"]} {"level":"info","ts":"2026-04-07T01:24:25.237771Z","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://162.253.55.221:2380"],"listen-peer-urls":["https://162.253.55.221:2380"],"advertise-client-urls":["https://162.253.55.221:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.221:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.221: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-07T01:24:25.241699Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.66329ms"} {"level":"info","ts":"2026-04-07T01:24:25.255116Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c187bdee547e8fd1","cluster-id":"ee7528b898b8b18e"} {"level":"info","ts":"2026-04-07T01:24:25.255246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T01:24:25.255278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became follower at term 0"} {"level":"info","ts":"2026-04-07T01:24:25.255299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c187bdee547e8fd1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T01:24:25.255312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became follower at term 1"} {"level":"info","ts":"2026-04-07T01:24:25.25536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 switched to configuration voters=(13945323602493476817)"} {"level":"warn","ts":"2026-04-07T01:24:25.260449Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T01:24:25.261817Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T01:24:25.263014Z","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-07T01:24:25.268016Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c187bdee547e8fd1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T01:24:25.268181Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c187bdee547e8fd1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T01:24:25.268415Z","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-07T01:24:25.268569Z","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-07T01:24:25.268583Z","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-07T01:24:25.269424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 switched to configuration voters=(13945323602493476817)"} {"level":"info","ts":"2026-04-07T01:24:25.27233Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ee7528b898b8b18e","local-member-id":"c187bdee547e8fd1","added-peer-id":"c187bdee547e8fd1","added-peer-peer-urls":["https://162.253.55.221:2380"]} {"level":"info","ts":"2026-04-07T01:24:25.278393Z","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-07T01:24:25.278447Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.221:2380"} {"level":"info","ts":"2026-04-07T01:24:25.2787Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.221:2380"} {"level":"info","ts":"2026-04-07T01:24:25.278966Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c187bdee547e8fd1","initial-advertise-peer-urls":["https://162.253.55.221:2380"],"listen-peer-urls":["https://162.253.55.221:2380"],"advertise-client-urls":["https://162.253.55.221:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.221:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T01:24:25.279007Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T01:24:25.856404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T01:24:25.85646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T01:24:25.856477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 received MsgPreVoteResp from c187bdee547e8fd1 at term 1"} {"level":"info","ts":"2026-04-07T01:24:25.856491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became candidate at term 2"} {"level":"info","ts":"2026-04-07T01:24:25.856499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 received MsgVoteResp from c187bdee547e8fd1 at term 2"} {"level":"info","ts":"2026-04-07T01:24:25.85651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became leader at term 2"} {"level":"info","ts":"2026-04-07T01:24:25.856536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c187bdee547e8fd1 elected leader c187bdee547e8fd1 at term 2"} {"level":"info","ts":"2026-04-07T01:24:25.857571Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c187bdee547e8fd1","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.221:2379]}","request-path":"/0/members/c187bdee547e8fd1/attributes","cluster-id":"ee7528b898b8b18e","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T01:24:25.857589Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:24:25.857636Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:24:25.857649Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:25.857919Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T01:24:25.857947Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T01:24:25.858766Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ee7528b898b8b18e","local-member-id":"c187bdee547e8fd1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:25.85891Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:25.858952Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:25.860222Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.221:2379"} {"level":"info","ts":"2026-04-07T01:24:25.861222Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T01:24:27.66974Z","caller":"traceutil/trace.go:171","msg":"trace[847360145] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"153.367042ms","start":"2026-04-07T01:24:27.515818Z","end":"2026-04-07T01:24:27.669185Z","steps":["trace[847360145] 'process raft request' (duration: 153.253319ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:39.224482Z","caller":"traceutil/trace.go:171","msg":"trace[997686006] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"248.995721ms","start":"2026-04-07T01:24:38.975442Z","end":"2026-04-07T01:24:39.224437Z","steps":["trace[997686006] 'process raft request' (duration: 234.797852ms)","trace[997686006] 'compare' (duration: 14.028174ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:25:10.183178Z","caller":"traceutil/trace.go:171","msg":"trace[1943609588] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"120.240947ms","start":"2026-04-07T01:25:10.062909Z","end":"2026-04-07T01:25:10.18315Z","steps":["trace[1943609588] 'read index received' (duration: 119.022463ms)","trace[1943609588] 'applied index is now lower than readState.Index' (duration: 1.217274ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:25:10.183319Z","caller":"traceutil/trace.go:171","msg":"trace[723858040] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"230.225774ms","start":"2026-04-07T01:25:09.953034Z","end":"2026-04-07T01:25:10.18326Z","steps":["trace[723858040] 'process raft request' (duration: 229.254067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:10.183486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.490774ms","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-04-07T01:25:10.183619Z","caller":"traceutil/trace.go:171","msg":"trace[127376817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"120.75501ms","start":"2026-04-07T01:25:10.062849Z","end":"2026-04-07T01:25:10.183604Z","steps":["trace[127376817] 'agreement among raft nodes before linearized reading' (duration: 120.450191ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:10.475968Z","caller":"traceutil/trace.go:171","msg":"trace[1910802156] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"221.302669ms","start":"2026-04-07T01:25:10.25464Z","end":"2026-04-07T01:25:10.475943Z","steps":["trace[1910802156] 'read index received' (duration: 221.069873ms)","trace[1910802156] 'applied index is now lower than readState.Index' (duration: 231.916µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:25:10.476141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.437955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:25:10.476187Z","caller":"traceutil/trace.go:171","msg":"trace[2086435955] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:633; }","duration":"221.587718ms","start":"2026-04-07T01:25:10.254587Z","end":"2026-04-07T01:25:10.476175Z","steps":["trace[2086435955] 'agreement among raft nodes before linearized reading' (duration: 221.450504ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:10.476529Z","caller":"traceutil/trace.go:171","msg":"trace[359867410] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"287.224067ms","start":"2026-04-07T01:25:10.189253Z","end":"2026-04-07T01:25:10.476477Z","steps":["trace[359867410] 'process raft request' (duration: 286.516828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:11.129948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.668756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xt78m\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-07T01:25:11.130093Z","caller":"traceutil/trace.go:171","msg":"trace[235962729] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xt78m; range_end:; response_count:1; response_revision:633; }","duration":"557.875211ms","start":"2026-04-07T01:25:10.572189Z","end":"2026-04-07T01:25:11.130065Z","steps":["trace[235962729] 'range keys from in-memory index tree' (duration: 557.450739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:11.130146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:10.572136Z","time spent":"557.998934ms","remote":"127.0.0.1:45164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-xt78m\" "} {"level":"warn","ts":"2026-04-07T01:25:11.130311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.134953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:25:11.130441Z","caller":"traceutil/trace.go:171","msg":"trace[1916100145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"378.323297ms","start":"2026-04-07T01:25:10.75209Z","end":"2026-04-07T01:25:11.130413Z","steps":["trace[1916100145] 'range keys from in-memory index tree' (duration: 377.566388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:11.130499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:10.752061Z","time spent":"378.421951ms","remote":"127.0.0.1:44994","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-04-07T01:25:11.160897Z","caller":"traceutil/trace.go:171","msg":"trace[1784189234] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"277.966724ms","start":"2026-04-07T01:25:10.882881Z","end":"2026-04-07T01:25:11.160848Z","steps":["trace[1784189234] 'process raft request' (duration: 277.116751ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:54.082323Z","caller":"traceutil/trace.go:171","msg":"trace[1235937131] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"345.610378ms","start":"2026-04-07T01:25:53.736682Z","end":"2026-04-07T01:25:54.082292Z","steps":["trace[1235937131] 'process raft request' (duration: 345.442604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:54.083116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:53.736646Z","time spent":"345.791751ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:25:54.099772Z","caller":"traceutil/trace.go:171","msg":"trace[988690710] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"358.521069ms","start":"2026-04-07T01:25:53.741199Z","end":"2026-04-07T01:25:54.09972Z","steps":["trace[988690710] 'process raft request' (duration: 358.351714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:54.100092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:53.74118Z","time spent":"358.734405ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:25:54.104193Z","caller":"traceutil/trace.go:171","msg":"trace[412020530] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1237; }","duration":"138.940745ms","start":"2026-04-07T01:25:53.965224Z","end":"2026-04-07T01:25:54.104165Z","steps":["trace[412020530] 'read index received' (duration: 117.024399ms)","trace[412020530] 'applied index is now lower than readState.Index' (duration: 21.915106ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:25:54.104421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.167452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:25:54.104516Z","caller":"traceutil/trace.go:171","msg":"trace[2145835099] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1205; }","duration":"139.347077ms","start":"2026-04-07T01:25:53.965152Z","end":"2026-04-07T01:25:54.104499Z","steps":["trace[2145835099] 'agreement among raft nodes before linearized reading' (duration: 139.125371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:41.411814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.566564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:26:41.411966Z","caller":"traceutil/trace.go:171","msg":"trace[1590707340] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"445.116823ms","start":"2026-04-07T01:26:40.966828Z","end":"2026-04-07T01:26:41.411945Z","steps":["trace[1590707340] 'process raft request' (duration: 188.152978ms)","trace[1590707340] 'compare' (duration: 256.271906ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:41.412039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:40.9668Z","time spent":"445.210595ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:41.420174Z","caller":"traceutil/trace.go:171","msg":"trace[671005885] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1948; }","duration":"330.110679ms","start":"2026-04-07T01:26:41.09002Z","end":"2026-04-07T01:26:41.42013Z","steps":["trace[671005885] 'read index received' (duration: 64.806657ms)","trace[671005885] 'applied index is now lower than readState.Index' (duration: 265.302652ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:41.420283Z","caller":"traceutil/trace.go:171","msg":"trace[812508836] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"345.173918ms","start":"2026-04-07T01:26:41.075075Z","end":"2026-04-07T01:26:41.420249Z","steps":["trace[812508836] 'process raft request' (duration: 344.88741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:41.420474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:41.075017Z","time spent":"345.340453ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:41.420522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.471858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29aa4d9d-89d0-4916-9c94-58f1bc3629a5\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T01:26:41.420642Z","caller":"traceutil/trace.go:171","msg":"trace[1294734495] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29aa4d9d-89d0-4916-9c94-58f1bc3629a5; range_end:; response_count:1; response_revision:1877; }","duration":"330.663433ms","start":"2026-04-07T01:26:41.08995Z","end":"2026-04-07T01:26:41.420614Z","steps":["trace[1294734495] 'agreement among raft nodes before linearized reading' (duration: 330.337634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:41.420724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:41.08992Z","time spent":"330.770066ms","remote":"127.0.0.1:45164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29aa4d9d-89d0-4916-9c94-58f1bc3629a5\" "} {"level":"info","ts":"2026-04-07T01:26:41.451969Z","caller":"traceutil/trace.go:171","msg":"trace[1277205601] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"226.782521ms","start":"2026-04-07T01:26:41.225138Z","end":"2026-04-07T01:26:41.451921Z","steps":["trace[1277205601] 'process raft request' (duration: 226.625136ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:41.68161Z","caller":"traceutil/trace.go:171","msg":"trace[400002845] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"122.658953ms","start":"2026-04-07T01:26:41.558904Z","end":"2026-04-07T01:26:41.681563Z","steps":["trace[400002845] 'process raft request' (duration: 117.913804ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:41.68161Z","caller":"traceutil/trace.go:171","msg":"trace[695950262] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"122.664273ms","start":"2026-04-07T01:26:41.558908Z","end":"2026-04-07T01:26:41.681572Z","steps":["trace[695950262] 'process raft request' (duration: 122.54587ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:41.681871Z","caller":"traceutil/trace.go:171","msg":"trace[613595117] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"122.698495ms","start":"2026-04-07T01:26:41.559144Z","end":"2026-04-07T01:26:41.681842Z","steps":["trace[613595117] 'process raft request' (duration: 122.369956ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:55.114621Z","caller":"traceutil/trace.go:171","msg":"trace[139689230] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"164.682539ms","start":"2026-04-07T01:26:54.949905Z","end":"2026-04-07T01:26:55.114587Z","steps":["trace[139689230] 'process raft request' (duration: 164.463833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:55.352142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.640406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:26:55.352185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.52301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:26:55.352232Z","caller":"traceutil/trace.go:171","msg":"trace[876231407] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1990; }","duration":"121.781669ms","start":"2026-04-07T01:26:55.230429Z","end":"2026-04-07T01:26:55.352211Z","steps":["trace[876231407] 'count revisions from in-memory index tree' (duration: 121.554914ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:55.352242Z","caller":"traceutil/trace.go:171","msg":"trace[1684866126] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1990; }","duration":"151.642024ms","start":"2026-04-07T01:26:55.200586Z","end":"2026-04-07T01:26:55.352228Z","steps":["trace[1684866126] 'count revisions from in-memory index tree' (duration: 151.422827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:26.817223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.868214ms","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-07T01:27:26.818023Z","caller":"traceutil/trace.go:171","msg":"trace[913548717] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2178; }","duration":"107.740097ms","start":"2026-04-07T01:27:26.710259Z","end":"2026-04-07T01:27:26.818Z","steps":["trace[913548717] 'range keys from in-memory index tree' (duration: 105.534707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:33.074382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.322892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-07T01:27:33.074488Z","caller":"traceutil/trace.go:171","msg":"trace[361940328] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2211; }","duration":"196.496207ms","start":"2026-04-07T01:27:32.877968Z","end":"2026-04-07T01:27:33.074464Z","steps":["trace[361940328] 'range keys from in-memory index tree' (duration: 196.092675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:33.074481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.88345ms","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-07T01:27:33.074591Z","caller":"traceutil/trace.go:171","msg":"trace[1284296776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2211; }","duration":"203.008904ms","start":"2026-04-07T01:27:32.871555Z","end":"2026-04-07T01:27:33.074563Z","steps":["trace[1284296776] 'range keys from in-memory index tree' (duration: 202.770257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:33.074481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.785682ms","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-07T01:27:33.07468Z","caller":"traceutil/trace.go:171","msg":"trace[1921274262] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2211; }","duration":"180.060109ms","start":"2026-04-07T01:27:32.894603Z","end":"2026-04-07T01:27:33.074663Z","steps":["trace[1921274262] 'range keys from in-memory index tree' (duration: 179.601436ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:33.601871Z","caller":"traceutil/trace.go:171","msg":"trace[1138527082] linearizableReadLoop","detail":"{readStateIndex:2298; appliedIndex:2297; }","duration":"151.995314ms","start":"2026-04-07T01:27:33.449841Z","end":"2026-04-07T01:27:33.601836Z","steps":["trace[1138527082] 'read index received' (duration: 151.753377ms)","trace[1138527082] 'applied index is now lower than readState.Index' (duration: 240.487µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:33.601952Z","caller":"traceutil/trace.go:171","msg":"trace[2014732204] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"233.798143ms","start":"2026-04-07T01:27:33.368124Z","end":"2026-04-07T01:27:33.601922Z","steps":["trace[2014732204] 'process raft request' (duration: 233.497165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:33.60205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.188129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:27:33.602107Z","caller":"traceutil/trace.go:171","msg":"trace[1971388786] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2214; }","duration":"152.334153ms","start":"2026-04-07T01:27:33.449759Z","end":"2026-04-07T01:27:33.602093Z","steps":["trace[1971388786] 'agreement among raft nodes before linearized reading' (duration: 152.207989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:34.060934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.709231ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:27:34.061117Z","caller":"traceutil/trace.go:171","msg":"trace[634006701] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"328.359452ms","start":"2026-04-07T01:27:33.73268Z","end":"2026-04-07T01:27:34.061039Z","steps":["trace[634006701] 'process raft request' (duration: 141.437955ms)","trace[634006701] 'compare' (duration: 186.550806ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:27:34.061272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:33.732655Z","time spent":"328.581937ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:27:34.110468Z","caller":"traceutil/trace.go:171","msg":"trace[1443037856] linearizableReadLoop","detail":"{readStateIndex:2300; appliedIndex:2298; }","duration":"338.384985ms","start":"2026-04-07T01:27:33.772047Z","end":"2026-04-07T01:27:34.110432Z","steps":["trace[1443037856] 'read index received' (duration: 102.102043ms)","trace[1443037856] 'applied index is now lower than readState.Index' (duration: 236.281582ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:34.110517Z","caller":"traceutil/trace.go:171","msg":"trace[1960268726] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"373.403339ms","start":"2026-04-07T01:27:33.737092Z","end":"2026-04-07T01:27:34.110495Z","steps":["trace[1960268726] 'process raft request' (duration: 373.188503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:34.110702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.640881ms","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-07T01:27:34.110746Z","caller":"traceutil/trace.go:171","msg":"trace[209849214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2216; }","duration":"338.759484ms","start":"2026-04-07T01:27:33.771975Z","end":"2026-04-07T01:27:34.110735Z","steps":["trace[209849214] 'agreement among raft nodes before linearized reading' (duration: 338.60769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:34.110732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:33.73706Z","time spent":"373.514403ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:27:34.110779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:33.771952Z","time spent":"338.819217ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T01:27:34.149331Z","caller":"traceutil/trace.go:171","msg":"trace[657112144] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"248.116454ms","start":"2026-04-07T01:27:33.901186Z","end":"2026-04-07T01:27:34.149303Z","steps":["trace[657112144] 'process raft request' (duration: 247.94636ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:35.369987Z","caller":"traceutil/trace.go:171","msg":"trace[1814878778] linearizableReadLoop","detail":"{readStateIndex:2822; appliedIndex:2821; }","duration":"100.750833ms","start":"2026-04-07T01:28:35.2692Z","end":"2026-04-07T01:28:35.36995Z","steps":["trace[1814878778] 'read index received' (duration: 100.465896ms)","trace[1814878778] 'applied index is now lower than readState.Index' (duration: 283.487µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:35.37019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.960699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:28:35.370241Z","caller":"traceutil/trace.go:171","msg":"trace[487532122] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2716; }","duration":"101.086933ms","start":"2026-04-07T01:28:35.269137Z","end":"2026-04-07T01:28:35.370224Z","steps":["trace[487532122] 'agreement among raft nodes before linearized reading' (duration: 100.952199ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:35.37064Z","caller":"traceutil/trace.go:171","msg":"trace[860007986] transaction","detail":"{read_only:false; response_revision:2716; number_of_response:1; }","duration":"306.714202ms","start":"2026-04-07T01:28:35.063912Z","end":"2026-04-07T01:28:35.370626Z","steps":["trace[860007986] 'process raft request' (duration: 305.837838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:35.370757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:28:35.063884Z","time spent":"306.795225ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:29:03.676665Z","caller":"traceutil/trace.go:171","msg":"trace[1416151798] transaction","detail":"{read_only:false; response_revision:2891; number_of_response:1; }","duration":"114.682943ms","start":"2026-04-07T01:29:03.561939Z","end":"2026-04-07T01:29:03.676622Z","steps":["trace[1416151798] 'process raft request' (duration: 80.308928ms)","trace[1416151798] 'compare' (duration: 34.18203ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:03.707891Z","caller":"traceutil/trace.go:171","msg":"trace[1378321276] transaction","detail":"{read_only:false; response_revision:2892; number_of_response:1; }","duration":"143.686443ms","start":"2026-04-07T01:29:03.564154Z","end":"2026-04-07T01:29:03.70784Z","steps":["trace[1378321276] 'process raft request' (duration: 143.471137ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:09.736678Z","caller":"traceutil/trace.go:171","msg":"trace[322426909] linearizableReadLoop","detail":"{readStateIndex:3036; appliedIndex:3035; }","duration":"111.609398ms","start":"2026-04-07T01:29:09.625048Z","end":"2026-04-07T01:29:09.736658Z","steps":["trace[322426909] 'read index received' (duration: 111.452045ms)","trace[322426909] 'applied index is now lower than readState.Index' (duration: 156.573µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:09.736772Z","caller":"traceutil/trace.go:171","msg":"trace[1529955040] transaction","detail":"{read_only:false; response_revision:2922; number_of_response:1; }","duration":"164.208212ms","start":"2026-04-07T01:29:09.572522Z","end":"2026-04-07T01:29:09.73673Z","steps":["trace[1529955040] 'process raft request' (duration: 164.015626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:09.737151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.076152ms","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-07T01:29:09.73764Z","caller":"traceutil/trace.go:171","msg":"trace[2076437353] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2922; }","duration":"112.626486ms","start":"2026-04-07T01:29:09.624984Z","end":"2026-04-07T01:29:09.737611Z","steps":["trace[2076437353] 'agreement among raft nodes before linearized reading' (duration: 111.773003ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:09.993167Z","caller":"traceutil/trace.go:171","msg":"trace[1475516536] transaction","detail":"{read_only:false; response_revision:2923; number_of_response:1; }","duration":"250.706267ms","start":"2026-04-07T01:29:09.742425Z","end":"2026-04-07T01:29:09.993132Z","steps":["trace[1475516536] 'process raft request' (duration: 219.783645ms)","trace[1475516536] 'compare' (duration: 30.787839ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:09.993687Z","caller":"traceutil/trace.go:171","msg":"trace[2025757543] linearizableReadLoop","detail":"{readStateIndex:3038; appliedIndex:3036; }","duration":"248.867737ms","start":"2026-04-07T01:29:09.74478Z","end":"2026-04-07T01:29:09.993648Z","steps":["trace[2025757543] 'read index received' (duration: 217.544744ms)","trace[2025757543] 'applied index is now lower than readState.Index' (duration: 31.321483ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:09.994107Z","caller":"traceutil/trace.go:171","msg":"trace[826270744] transaction","detail":"{read_only:false; response_revision:2924; number_of_response:1; }","duration":"250.712297ms","start":"2026-04-07T01:29:09.743329Z","end":"2026-04-07T01:29:09.994041Z","steps":["trace[826270744] 'process raft request' (duration: 250.155092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:09.994166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.296472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:29:09.994217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.399022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1317"} {"level":"info","ts":"2026-04-07T01:29:09.994325Z","caller":"traceutil/trace.go:171","msg":"trace[136351529] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2924; }","duration":"249.544095ms","start":"2026-04-07T01:29:09.744753Z","end":"2026-04-07T01:29:09.994297Z","steps":["trace[136351529] 'agreement among raft nodes before linearized reading' (duration: 249.120833ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:09.994274Z","caller":"traceutil/trace.go:171","msg":"trace[1538795060] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2924; }","duration":"244.473397ms","start":"2026-04-07T01:29:09.749773Z","end":"2026-04-07T01:29:09.994247Z","steps":["trace[1538795060] 'agreement among raft nodes before linearized reading' (duration: 244.304953ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:03.853221Z","caller":"traceutil/trace.go:171","msg":"trace[522629029] linearizableReadLoop","detail":"{readStateIndex:5161; appliedIndex:5160; }","duration":"101.96133ms","start":"2026-04-07T01:33:03.751236Z","end":"2026-04-07T01:33:03.853197Z","steps":["trace[522629029] 'read index received' (duration: 88.883936ms)","trace[522629029] 'applied index is now lower than readState.Index' (duration: 13.076424ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:33:03.853398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.149875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:33:03.853437Z","caller":"traceutil/trace.go:171","msg":"trace[2141011590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4969; }","duration":"102.244488ms","start":"2026-04-07T01:33:03.751181Z","end":"2026-04-07T01:33:03.853426Z","steps":["trace[2141011590] 'agreement among raft nodes before linearized reading' (duration: 102.123105ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:03.853467Z","caller":"traceutil/trace.go:171","msg":"trace[982081549] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"153.250289ms","start":"2026-04-07T01:33:03.700184Z","end":"2026-04-07T01:33:03.853435Z","steps":["trace[982081549] 'process raft request' (duration: 139.887728ms)","trace[982081549] 'compare' (duration: 12.868318ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:07.900864Z","caller":"traceutil/trace.go:171","msg":"trace[1120173973] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"290.013626ms","start":"2026-04-07T01:33:07.610826Z","end":"2026-04-07T01:33:07.900839Z","steps":["trace[1120173973] 'process raft request' (duration: 289.846072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:07.901158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.479621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-03693dd8-e280-4d08-9328-de3431074459\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-07T01:33:07.901252Z","caller":"traceutil/trace.go:171","msg":"trace[1465648700] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-03693dd8-e280-4d08-9328-de3431074459; range_end:; response_count:1; response_revision:5119; }","duration":"265.610995ms","start":"2026-04-07T01:33:07.635621Z","end":"2026-04-07T01:33:07.901232Z","steps":["trace[1465648700] 'agreement among raft nodes before linearized reading' (duration: 265.315357ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:07.901283Z","caller":"traceutil/trace.go:171","msg":"trace[1600594884] linearizableReadLoop","detail":"{readStateIndex:5315; appliedIndex:5314; }","duration":"265.149411ms","start":"2026-04-07T01:33:07.635655Z","end":"2026-04-07T01:33:07.900804Z","steps":["trace[1600594884] 'read index received' (duration: 264.997147ms)","trace[1600594884] 'applied index is now lower than readState.Index' (duration: 151.214µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:08.041932Z","caller":"traceutil/trace.go:171","msg":"trace[569990923] transaction","detail":"{read_only:false; response_revision:5121; number_of_response:1; }","duration":"133.103629ms","start":"2026-04-07T01:33:07.90881Z","end":"2026-04-07T01:33:08.041914Z","steps":["trace[569990923] 'process raft request' (duration: 133.066769ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:08.041969Z","caller":"traceutil/trace.go:171","msg":"trace[69790403] linearizableReadLoop","detail":"{readStateIndex:5316; appliedIndex:5315; }","duration":"140.620897ms","start":"2026-04-07T01:33:07.901323Z","end":"2026-04-07T01:33:08.041944Z","steps":["trace[69790403] 'read index received' (duration: 97.065052ms)","trace[69790403] 'applied index is now lower than readState.Index' (duration: 43.554585ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:33:08.042062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.217716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:33:08.042101Z","caller":"traceutil/trace.go:171","msg":"trace[128182724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5121; }","duration":"291.303809ms","start":"2026-04-07T01:33:07.750785Z","end":"2026-04-07T01:33:08.042089Z","steps":["trace[128182724] 'agreement among raft nodes before linearized reading' (duration: 291.226687ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:08.04219Z","caller":"traceutil/trace.go:171","msg":"trace[441304557] transaction","detail":"{read_only:false; response_revision:5120; number_of_response:1; }","duration":"174.664433ms","start":"2026-04-07T01:33:07.867519Z","end":"2026-04-07T01:33:08.042184Z","steps":["trace[441304557] 'process raft request' (duration: 130.858401ms)","trace[441304557] 'compare' (duration: 43.411451ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:33:08.042345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.200755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T01:33:08.042388Z","caller":"traceutil/trace.go:171","msg":"trace[2015717551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5121; }","duration":"159.285968ms","start":"2026-04-07T01:33:07.883092Z","end":"2026-04-07T01:33:08.042378Z","steps":["trace[2015717551] 'agreement among raft nodes before linearized reading' (duration: 159.130545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:23.298577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.328298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:33:23.29869Z","caller":"traceutil/trace.go:171","msg":"trace[1685880331] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:5378; }","duration":"119.496113ms","start":"2026-04-07T01:33:23.179167Z","end":"2026-04-07T01:33:23.298664Z","steps":["trace[1685880331] 'range keys from in-memory index tree' (duration: 119.192544ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:25.684343Z","caller":"traceutil/trace.go:171","msg":"trace[827647852] transaction","detail":"{read_only:false; response_revision:5451; number_of_response:1; }","duration":"277.968889ms","start":"2026-04-07T01:33:25.406347Z","end":"2026-04-07T01:33:25.684315Z","steps":["trace[827647852] 'process raft request' (duration: 277.763764ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:25.703432Z","caller":"traceutil/trace.go:171","msg":"trace[1338193388] transaction","detail":"{read_only:false; response_revision:5452; number_of_response:1; }","duration":"293.933109ms","start":"2026-04-07T01:33:25.409478Z","end":"2026-04-07T01:33:25.703411Z","steps":["trace[1338193388] 'process raft request' (duration: 293.717973ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:25.703759Z","caller":"traceutil/trace.go:171","msg":"trace[756579186] transaction","detail":"{read_only:false; response_revision:5453; number_of_response:1; }","duration":"251.644917ms","start":"2026-04-07T01:33:25.452082Z","end":"2026-04-07T01:33:25.703727Z","steps":["trace[756579186] 'process raft request' (duration: 251.265196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:25.834069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.270835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:33:25.834268Z","caller":"traceutil/trace.go:171","msg":"trace[1052677248] linearizableReadLoop","detail":"{readStateIndex:5656; appliedIndex:5654; }","duration":"423.325971ms","start":"2026-04-07T01:33:25.410923Z","end":"2026-04-07T01:33:25.834249Z","steps":["trace[1052677248] 'read index received' (duration: 273.164023ms)","trace[1052677248] 'applied index is now lower than readState.Index' (duration: 150.160688ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:25.834397Z","caller":"traceutil/trace.go:171","msg":"trace[1528679658] transaction","detail":"{read_only:false; response_revision:5455; number_of_response:1; }","duration":"265.015158ms","start":"2026-04-07T01:33:25.569359Z","end":"2026-04-07T01:33:25.834374Z","steps":["trace[1528679658] 'process raft request' (duration: 264.807573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:25.834552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.631099ms","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-07T01:33:25.834548Z","caller":"traceutil/trace.go:171","msg":"trace[708963769] transaction","detail":"{read_only:false; response_revision:5454; number_of_response:1; }","duration":"375.214827ms","start":"2026-04-07T01:33:25.459308Z","end":"2026-04-07T01:33:25.834523Z","steps":["trace[708963769] 'process raft request' (duration: 244.398597ms)","trace[708963769] 'compare' (duration: 130.118111ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:25.834587Z","caller":"traceutil/trace.go:171","msg":"trace[197729328] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5455; }","duration":"423.689201ms","start":"2026-04-07T01:33:25.410888Z","end":"2026-04-07T01:33:25.834578Z","steps":["trace[197729328] 'agreement among raft nodes before linearized reading' (duration: 423.514386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:25.834618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:33:25.410878Z","time spent":"423.732771ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T01:33:25.834659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:33:25.459291Z","time spent":"375.306088ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:33:25.834715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.55484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T01:33:25.834799Z","caller":"traceutil/trace.go:171","msg":"trace[1397333421] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5455; }","duration":"236.686953ms","start":"2026-04-07T01:33:25.598092Z","end":"2026-04-07T01:33:25.834779Z","steps":["trace[1397333421] 'agreement among raft nodes before linearized reading' (duration: 236.425286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:25.834813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.68543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4a61a6a1-c47a-45de-9a69-a85abf6007dc\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-04-07T01:33:25.834926Z","caller":"traceutil/trace.go:171","msg":"trace[331097893] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4a61a6a1-c47a-45de-9a69-a85abf6007dc; range_end:; response_count:1; response_revision:5455; }","duration":"264.813833ms","start":"2026-04-07T01:33:25.570087Z","end":"2026-04-07T01:33:25.834901Z","steps":["trace[331097893] 'agreement among raft nodes before linearized reading' (duration: 264.585587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:25.835537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.398123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-07T01:33:25.835703Z","caller":"traceutil/trace.go:171","msg":"trace[1916151164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5455; }","duration":"423.607278ms","start":"2026-04-07T01:33:25.412083Z","end":"2026-04-07T01:33:25.835691Z","steps":["trace[1916151164] 'agreement among raft nodes before linearized reading' (duration: 422.377966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:25.83574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:33:25.412063Z","time spent":"423.6641ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T01:33:26.079708Z","caller":"traceutil/trace.go:171","msg":"trace[1165260158] linearizableReadLoop","detail":"{readStateIndex:5662; appliedIndex:5660; }","duration":"142.943589ms","start":"2026-04-07T01:33:25.936745Z","end":"2026-04-07T01:33:26.079689Z","steps":["trace[1165260158] 'read index received' (duration: 142.388034ms)","trace[1165260158] 'applied index is now lower than readState.Index' (duration: 554.595µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:26.079807Z","caller":"traceutil/trace.go:171","msg":"trace[87339349] transaction","detail":"{read_only:false; response_revision:5458; number_of_response:1; }","duration":"239.57573ms","start":"2026-04-07T01:33:25.840218Z","end":"2026-04-07T01:33:26.079794Z","steps":["trace[87339349] 'process raft request' (duration: 239.399895ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:26.080174Z","caller":"traceutil/trace.go:171","msg":"trace[223050247] transaction","detail":"{read_only:false; response_revision:5457; number_of_response:1; }","duration":"239.862717ms","start":"2026-04-07T01:33:25.839864Z","end":"2026-04-07T01:33:26.079727Z","steps":["trace[223050247] 'process raft request' (duration: 239.368625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:26.08179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.007832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:33:26.081928Z","caller":"traceutil/trace.go:171","msg":"trace[938669127] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:5458; }","duration":"145.180178ms","start":"2026-04-07T01:33:25.936694Z","end":"2026-04-07T01:33:26.081874Z","steps":["trace[938669127] 'agreement among raft nodes before linearized reading' (duration: 143.073453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:26.343133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.977235ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:33:26.343319Z","caller":"traceutil/trace.go:171","msg":"trace[1092181411] linearizableReadLoop","detail":"{readStateIndex:5663; appliedIndex:5662; }","duration":"208.705428ms","start":"2026-04-07T01:33:26.134586Z","end":"2026-04-07T01:33:26.343288Z","steps":["trace[1092181411] 'read index received' (duration: 53.323722ms)","trace[1092181411] 'applied index is now lower than readState.Index' (duration: 155.376545ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:26.343474Z","caller":"traceutil/trace.go:171","msg":"trace[1464679128] transaction","detail":"{read_only:false; response_revision:5459; number_of_response:1; }","duration":"229.887105ms","start":"2026-04-07T01:33:26.113498Z","end":"2026-04-07T01:33:26.343385Z","steps":["trace[1464679128] 'process raft request' (duration: 74.495569ms)","trace[1464679128] 'compare' (duration: 154.823671ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:33:26.343667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.044626ms","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-07T01:33:26.344221Z","caller":"traceutil/trace.go:171","msg":"trace[1597541200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5459; }","duration":"209.203251ms","start":"2026-04-07T01:33:26.134549Z","end":"2026-04-07T01:33:26.343752Z","steps":["trace[1597541200] 'agreement among raft nodes before linearized reading' (duration: 208.856753ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:25.967014Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3010} {"level":"warn","ts":"2026-04-07T01:34:26.076851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.482745ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:34:26.077002Z","caller":"traceutil/trace.go:171","msg":"trace[1831933921] linearizableReadLoop","detail":"{readStateIndex:6268; appliedIndex:6267; }","duration":"103.73333ms","start":"2026-04-07T01:34:25.973216Z","end":"2026-04-07T01:34:26.076949Z","steps":["trace[1831933921] 'read index received' (duration: 30.201µs)","trace[1831933921] 'applied index is now lower than readState.Index' (duration: 103.701289ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:34:26.07716Z","caller":"traceutil/trace.go:171","msg":"trace[998295105] transaction","detail":"{read_only:false; response_revision:6046; number_of_response:1; }","duration":"147.68078ms","start":"2026-04-07T01:34:25.929302Z","end":"2026-04-07T01:34:26.076983Z","steps":["trace[998295105] 'process raft request' (duration: 40.969939ms)","trace[998295105] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/openstack/messaging-topology-operator-leader-election; req_size:553; } (duration: 106.287859ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:34:26.093387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.166916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-04-07T01:34:26.093442Z","caller":"traceutil/trace.go:171","msg":"trace[257363861] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:6046; }","duration":"120.250388ms","start":"2026-04-07T01:34:25.973176Z","end":"2026-04-07T01:34:26.093426Z","steps":["trace[257363861] 'agreement among raft nodes before linearized reading' (duration: 103.866333ms)","trace[257363861] 'range keys from in-memory index tree' (duration: 16.216679ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:34:26.203497Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3010,"took":"234.846152ms","hash":904127066,"current-db-size-bytes":57958400,"current-db-size":"58 MB","current-db-size-in-use-bytes":31150080,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-07T01:34:26.203568Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":904127066,"revision":3010,"compact-revision":-1} {"level":"info","ts":"2026-04-07T01:34:26.322004Z","caller":"traceutil/trace.go:171","msg":"trace[151115046] linearizableReadLoop","detail":"{readStateIndex:6270; appliedIndex:6269; }","duration":"103.101562ms","start":"2026-04-07T01:34:26.218882Z","end":"2026-04-07T01:34:26.321984Z","steps":["trace[151115046] 'read index received' (duration: 81.324033ms)","trace[151115046] 'applied index is now lower than readState.Index' (duration: 21.776819ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:34:26.322112Z","caller":"traceutil/trace.go:171","msg":"trace[2138550101] transaction","detail":"{read_only:false; response_revision:6048; number_of_response:1; }","duration":"105.107147ms","start":"2026-04-07T01:34:26.216964Z","end":"2026-04-07T01:34:26.322071Z","steps":["trace[2138550101] 'process raft request' (duration: 83.327036ms)","trace[2138550101] 'compare' (duration: 21.589756ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:34:26.322184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.287988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T01:34:26.322256Z","caller":"traceutil/trace.go:171","msg":"trace[494248122] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6048; }","duration":"103.387981ms","start":"2026-04-07T01:34:26.21885Z","end":"2026-04-07T01:34:26.322238Z","steps":["trace[494248122] 'agreement among raft nodes before linearized reading' (duration: 103.202077ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:25.980597Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6044} {"level":"info","ts":"2026-04-07T01:39:26.111765Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6044,"took":"128.053736ms","hash":2810404739,"current-db-size-bytes":57958400,"current-db-size":"58 MB","current-db-size-in-use-bytes":21913600,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-07T01:39:26.111863Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2810404739,"revision":6044,"compact-revision":3010} {"level":"warn","ts":"2026-04-07T01:39:37.356902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.483135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nwj8g\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-07T01:39:37.357009Z","caller":"traceutil/trace.go:171","msg":"trace[1808865110] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nwj8g; range_end:; response_count:1; response_revision:8352; }","duration":"354.623969ms","start":"2026-04-07T01:39:37.002359Z","end":"2026-04-07T01:39:37.356983Z","steps":["trace[1808865110] 'range keys from in-memory index tree' (duration: 354.33271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:37.35708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:37.002339Z","time spent":"354.728742ms","remote":"127.0.0.1:45164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-nwj8g\" "} {"level":"info","ts":"2026-04-07T01:39:37.357284Z","caller":"traceutil/trace.go:171","msg":"trace[1964654590] linearizableReadLoop","detail":"{readStateIndex:8649; appliedIndex:8648; }","duration":"228.319819ms","start":"2026-04-07T01:39:37.128911Z","end":"2026-04-07T01:39:37.357231Z","steps":["trace[1964654590] 'read index received' (duration: 225.785622ms)","trace[1964654590] 'applied index is now lower than readState.Index' (duration: 2.532737ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:39:37.357461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.533235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:39:37.357498Z","caller":"traceutil/trace.go:171","msg":"trace[811768023] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:8353; }","duration":"228.623288ms","start":"2026-04-07T01:39:37.128861Z","end":"2026-04-07T01:39:37.357484Z","steps":["trace[811768023] 'agreement among raft nodes before linearized reading' (duration: 228.525425ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:37.357693Z","caller":"traceutil/trace.go:171","msg":"trace[2064306073] transaction","detail":"{read_only:false; response_revision:8353; number_of_response:1; }","duration":"354.891465ms","start":"2026-04-07T01:39:37.002399Z","end":"2026-04-07T01:39:37.357291Z","steps":["trace[2064306073] 'process raft request' (duration: 352.279766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:37.357883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:37.002368Z","time spent":"355.40905ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:39:37.358729Z","caller":"traceutil/trace.go:171","msg":"trace[1743819975] transaction","detail":"{read_only:false; response_revision:8354; number_of_response:1; }","duration":"150.500228ms","start":"2026-04-07T01:39:37.208187Z","end":"2026-04-07T01:39:37.358687Z","steps":["trace[1743819975] 'process raft request' (duration: 150.253041ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:37.358841Z","caller":"traceutil/trace.go:171","msg":"trace[2081086303] transaction","detail":"{read_only:false; response_revision:8355; number_of_response:1; }","duration":"146.700595ms","start":"2026-04-07T01:39:37.212126Z","end":"2026-04-07T01:39:37.358826Z","steps":["trace[2081086303] 'process raft request' (duration: 146.49733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:37.35895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.122955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:39:37.359021Z","caller":"traceutil/trace.go:171","msg":"trace[741099525] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:8355; }","duration":"129.238668ms","start":"2026-04-07T01:39:37.229769Z","end":"2026-04-07T01:39:37.359008Z","steps":["trace[741099525] 'agreement among raft nodes before linearized reading' (duration: 129.018002ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:39.234798Z","caller":"traceutil/trace.go:171","msg":"trace[1221505235] linearizableReadLoop","detail":"{readStateIndex:8658; appliedIndex:8657; }","duration":"333.593265ms","start":"2026-04-07T01:39:38.901179Z","end":"2026-04-07T01:39:39.234772Z","steps":["trace[1221505235] 'read index received' (duration: 333.485362ms)","trace[1221505235] 'applied index is now lower than readState.Index' (duration: 106.743µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:39:39.234832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:38.855562Z","time spent":"379.261318ms","remote":"127.0.0.1:45022","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-07T01:39:39.234953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.533536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:39:39.234983Z","caller":"traceutil/trace.go:171","msg":"trace[1141375773] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:8361; }","duration":"114.637987ms","start":"2026-04-07T01:39:39.120337Z","end":"2026-04-07T01:39:39.234975Z","steps":["trace[1141375773] 'agreement among raft nodes before linearized reading' (duration: 114.546454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:39.235202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.003317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-07T01:39:39.235277Z","caller":"traceutil/trace.go:171","msg":"trace[1800174306] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8361; }","duration":"334.136761ms","start":"2026-04-07T01:39:38.901123Z","end":"2026-04-07T01:39:39.235259Z","steps":["trace[1800174306] 'agreement among raft nodes before linearized reading' (duration: 333.75856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:39.235311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:38.901097Z","time spent":"334.207242ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T01:39:39.855591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10363237276996236416,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:39:40.373238Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10363237276996236416,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T01:39:40.408101Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.079385701s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T01:39:40.409133Z","caller":"traceutil/trace.go:171","msg":"trace[730190637] transaction","detail":"{read_only:false; response_revision:8364; number_of_response:1; }","duration":"1.080569243s","start":"2026-04-07T01:39:39.328541Z","end":"2026-04-07T01:39:40.40911Z","steps":["trace[730190637] 'process raft request' (duration: 1.079789031s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:40.409248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:39.3285Z","time spent":"1.080680385s","remote":"127.0.0.1:45156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19392,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:39:40.410481Z","caller":"traceutil/trace.go:171","msg":"trace[1413623699] transaction","detail":"{read_only:false; response_revision:8366; number_of_response:1; }","duration":"1.046133231s","start":"2026-04-07T01:39:39.364327Z","end":"2026-04-07T01:39:40.41046Z","steps":["trace[1413623699] 'process raft request' (duration: 1.046045679s)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:40.410501Z","caller":"traceutil/trace.go:171","msg":"trace[1061621550] transaction","detail":"{read_only:false; response_revision:8365; number_of_response:1; }","duration":"1.046254394s","start":"2026-04-07T01:39:39.364212Z","end":"2026-04-07T01:39:40.410466Z","steps":["trace[1061621550] 'process raft request' (duration: 1.046074669s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:40.410605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:39.36431Z","time spent":"1.046219934s","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:39:40.410687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:39.36418Z","time spent":"1.046362347s","remote":"127.0.0.1:45220","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-04-07T01:39:40.410736Z","caller":"traceutil/trace.go:171","msg":"trace[388456555] linearizableReadLoop","detail":"{readStateIndex:8665; appliedIndex:8660; }","duration":"1.055308997s","start":"2026-04-07T01:39:39.355406Z","end":"2026-04-07T01:39:40.410715Z","steps":["trace[388456555] 'read index received' (duration: 1.052931613s)","trace[388456555] 'applied index is now lower than readState.Index' (duration: 2.376684ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:40.41078Z","caller":"traceutil/trace.go:171","msg":"trace[998238622] transaction","detail":"{read_only:false; response_revision:8367; number_of_response:1; }","duration":"788.326363ms","start":"2026-04-07T01:39:39.622443Z","end":"2026-04-07T01:39:40.410769Z","steps":["trace[998238622] 'process raft request' (duration: 787.970103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:40.410837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:39.622413Z","time spent":"788.400434ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:39:40.410818Z","caller":"traceutil/trace.go:171","msg":"trace[1396192239] transaction","detail":"{read_only:false; response_revision:8368; number_of_response:1; }","duration":"781.332626ms","start":"2026-04-07T01:39:39.629458Z","end":"2026-04-07T01:39:40.41079Z","steps":["trace[1396192239] 'process raft request' (duration: 781.164092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:40.410997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.893996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nwj8g\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-07T01:39:40.411027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.910189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-07T01:39:40.411005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:39.629444Z","time spent":"781.464699ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:39:40.41109Z","caller":"traceutil/trace.go:171","msg":"trace[1871466772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8368; }","duration":"277.021772ms","start":"2026-04-07T01:39:40.13406Z","end":"2026-04-07T01:39:40.411082Z","steps":["trace[1871466772] 'agreement among raft nodes before linearized reading' (duration: 276.886999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:40.411129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.402912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T01:39:40.411149Z","caller":"traceutil/trace.go:171","msg":"trace[182619708] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8368; }","duration":"462.458833ms","start":"2026-04-07T01:39:39.948685Z","end":"2026-04-07T01:39:40.411144Z","steps":["trace[182619708] 'agreement among raft nodes before linearized reading' (duration: 462.394172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:40.410873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055449621s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:39:40.411174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:39.948664Z","time spent":"462.504196ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-07T01:39:40.411188Z","caller":"traceutil/trace.go:171","msg":"trace[321366880] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8368; }","duration":"1.055818801s","start":"2026-04-07T01:39:39.355352Z","end":"2026-04-07T01:39:40.411171Z","steps":["trace[321366880] 'agreement among raft nodes before linearized reading' (duration: 1.055466751s)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:40.411056Z","caller":"traceutil/trace.go:171","msg":"trace[173360040] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nwj8g; range_end:; response_count:1; response_revision:8368; }","duration":"789.951996ms","start":"2026-04-07T01:39:39.621069Z","end":"2026-04-07T01:39:40.411021Z","steps":["trace[173360040] 'agreement among raft nodes before linearized reading' (duration: 789.832843ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:40.411233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:39.355329Z","time spent":"1.055886691s","remote":"127.0.0.1:43854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:39:40.411262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:39.621054Z","time spent":"790.199353ms","remote":"127.0.0.1:45164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-nwj8g\" "} {"level":"warn","ts":"2026-04-07T01:39:40.411308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.526423ms","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-07T01:39:40.411338Z","caller":"traceutil/trace.go:171","msg":"trace[64361629] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8368; }","duration":"478.598796ms","start":"2026-04-07T01:39:39.932733Z","end":"2026-04-07T01:39:40.411332Z","steps":["trace[64361629] 'agreement among raft nodes before linearized reading' (duration: 478.523393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:40.411354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:39.932706Z","time spent":"478.644167ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T01:39:40.411411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.443514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:39:40.411425Z","caller":"traceutil/trace.go:171","msg":"trace[1220964262] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8368; }","duration":"659.503236ms","start":"2026-04-07T01:39:39.751917Z","end":"2026-04-07T01:39:40.41142Z","steps":["trace[1220964262] 'agreement among raft nodes before linearized reading' (duration: 659.480536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:40.41144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:39.751884Z","time spent":"659.552767ms","remote":"127.0.0.1:44994","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-04-07T01:39:43.042189Z","caller":"traceutil/trace.go:171","msg":"trace[107125426] transaction","detail":"{read_only:false; response_revision:8383; number_of_response:1; }","duration":"482.629134ms","start":"2026-04-07T01:39:42.55953Z","end":"2026-04-07T01:39:43.042159Z","steps":["trace[107125426] 'process raft request' (duration: 385.632878ms)","trace[107125426] 'compare' (duration: 96.8167ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:39:43.04233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:42.559502Z","time spent":"482.755167ms","remote":"127.0.0.1:45220","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-07T01:40:08.631894Z","caller":"traceutil/trace.go:171","msg":"trace[397322089] transaction","detail":"{read_only:false; response_revision:8516; number_of_response:1; }","duration":"109.855966ms","start":"2026-04-07T01:40:08.522008Z","end":"2026-04-07T01:40:08.631864Z","steps":["trace[397322089] 'process raft request' (duration: 109.691172ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:40:21.179456Z","caller":"traceutil/trace.go:171","msg":"trace[619848161] transaction","detail":"{read_only:false; response_revision:8640; number_of_response:1; }","duration":"346.423481ms","start":"2026-04-07T01:40:20.833Z","end":"2026-04-07T01:40:21.179423Z","steps":["trace[619848161] 'process raft request' (duration: 344.960118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:21.179664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:40:20.832972Z","time spent":"346.575284ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:40:21.219562Z","caller":"traceutil/trace.go:171","msg":"trace[1074918926] linearizableReadLoop","detail":"{readStateIndex:8949; appliedIndex:8947; }","duration":"383.64156ms","start":"2026-04-07T01:40:20.835896Z","end":"2026-04-07T01:40:21.219538Z","steps":["trace[1074918926] 'read index received' (duration: 342.093403ms)","trace[1074918926] 'applied index is now lower than readState.Index' (duration: 41.547167ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:40:21.219675Z","caller":"traceutil/trace.go:171","msg":"trace[772056459] transaction","detail":"{read_only:false; response_revision:8641; number_of_response:1; }","duration":"384.0928ms","start":"2026-04-07T01:40:20.835571Z","end":"2026-04-07T01:40:21.219663Z","steps":["trace[772056459] 'process raft request' (duration: 383.834864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:21.220089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.151017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T01:40:21.220168Z","caller":"traceutil/trace.go:171","msg":"trace[109718165] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8641; }","duration":"382.269418ms","start":"2026-04-07T01:40:20.837869Z","end":"2026-04-07T01:40:21.220138Z","steps":["trace[109718165] 'agreement among raft nodes before linearized reading' (duration: 382.084534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:21.220209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:40:20.837847Z","time spent":"382.35252ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T01:40:21.22031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.733714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:40:21.220339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.417928ms","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-07T01:40:21.220397Z","caller":"traceutil/trace.go:171","msg":"trace[527755156] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:8641; }","duration":"170.879687ms","start":"2026-04-07T01:40:21.049491Z","end":"2026-04-07T01:40:21.220371Z","steps":["trace[527755156] 'agreement among raft nodes before linearized reading' (duration: 170.724954ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:40:21.220418Z","caller":"traceutil/trace.go:171","msg":"trace[1263739405] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8641; }","duration":"384.53396ms","start":"2026-04-07T01:40:20.835865Z","end":"2026-04-07T01:40:21.220399Z","steps":["trace[1263739405] 'agreement among raft nodes before linearized reading' (duration: 384.285904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:21.220453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.046411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nwj8g\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-07T01:40:21.220468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:40:20.835856Z","time spent":"384.603781ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T01:40:21.220492Z","caller":"traceutil/trace.go:171","msg":"trace[272970062] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nwj8g; range_end:; response_count:1; response_revision:8641; }","duration":"367.108301ms","start":"2026-04-07T01:40:20.853374Z","end":"2026-04-07T01:40:21.220482Z","steps":["trace[272970062] 'agreement among raft nodes before linearized reading' (duration: 366.993229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:21.220525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:40:20.835545Z","time spent":"384.154782ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:40:21.220554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:40:20.85336Z","time spent":"367.186794ms","remote":"127.0.0.1:45164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-nwj8g\" "} {"level":"info","ts":"2026-04-07T01:40:21.390382Z","caller":"traceutil/trace.go:171","msg":"trace[1653148713] transaction","detail":"{read_only:false; response_revision:8643; number_of_response:1; }","duration":"165.34042ms","start":"2026-04-07T01:40:21.225015Z","end":"2026-04-07T01:40:21.390356Z","steps":["trace[1653148713] 'process raft request' (duration: 157.981552ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:40:21.390553Z","caller":"traceutil/trace.go:171","msg":"trace[768223014] linearizableReadLoop","detail":"{readStateIndex:8952; appliedIndex:8949; }","duration":"155.577168ms","start":"2026-04-07T01:40:21.23495Z","end":"2026-04-07T01:40:21.390527Z","steps":["trace[768223014] 'read index received' (duration: 18.468011ms)","trace[768223014] 'applied index is now lower than readState.Index' (duration: 137.107197ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:40:21.390663Z","caller":"traceutil/trace.go:171","msg":"trace[1811240333] transaction","detail":"{read_only:false; response_revision:8644; number_of_response:1; }","duration":"165.576537ms","start":"2026-04-07T01:40:21.225075Z","end":"2026-04-07T01:40:21.390652Z","steps":["trace[1811240333] 'process raft request' (duration: 165.242109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:21.39098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.999687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228872"} {"level":"info","ts":"2026-04-07T01:40:21.391032Z","caller":"traceutil/trace.go:171","msg":"trace[2019143421] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8644; }","duration":"156.077529ms","start":"2026-04-07T01:40:21.234944Z","end":"2026-04-07T01:40:21.391022Z","steps":["trace[2019143421] 'agreement among raft nodes before linearized reading' (duration: 155.67998ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:40:24.926258Z","caller":"traceutil/trace.go:171","msg":"trace[1209234513] transaction","detail":"{read_only:false; response_revision:8655; number_of_response:1; }","duration":"207.445861ms","start":"2026-04-07T01:40:24.718771Z","end":"2026-04-07T01:40:24.926217Z","steps":["trace[1209234513] 'process raft request' (duration: 207.137384ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:40:24.926659Z","caller":"traceutil/trace.go:171","msg":"trace[2093600717] linearizableReadLoop","detail":"{readStateIndex:8965; appliedIndex:8963; }","duration":"175.488373ms","start":"2026-04-07T01:40:24.751136Z","end":"2026-04-07T01:40:24.926625Z","steps":["trace[2093600717] 'read index received' (duration: 174.943821ms)","trace[2093600717] 'applied index is now lower than readState.Index' (duration: 543.472µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:40:24.926717Z","caller":"traceutil/trace.go:171","msg":"trace[1233315] transaction","detail":"{read_only:false; response_revision:8656; number_of_response:1; }","duration":"207.922862ms","start":"2026-04-07T01:40:24.718778Z","end":"2026-04-07T01:40:24.926701Z","steps":["trace[1233315] 'process raft request' (duration: 207.37649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:24.926802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.659706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:40:24.926861Z","caller":"traceutil/trace.go:171","msg":"trace[1869598804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8656; }","duration":"175.81989ms","start":"2026-04-07T01:40:24.751027Z","end":"2026-04-07T01:40:24.926847Z","steps":["trace[1869598804] 'agreement among raft nodes before linearized reading' (duration: 175.701448ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:40:24.98574Z","caller":"traceutil/trace.go:171","msg":"trace[1211423702] transaction","detail":"{read_only:false; response_revision:8657; number_of_response:1; }","duration":"205.452316ms","start":"2026-04-07T01:40:24.780254Z","end":"2026-04-07T01:40:24.985706Z","steps":["trace[1211423702] 'process raft request' (duration: 194.404564ms)","trace[1211423702] 'compare' (duration: 10.790026ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:40:24.985769Z","caller":"traceutil/trace.go:171","msg":"trace[2111795802] transaction","detail":"{read_only:false; response_revision:8658; number_of_response:1; }","duration":"199.507651ms","start":"2026-04-07T01:40:24.786241Z","end":"2026-04-07T01:40:24.985748Z","steps":["trace[2111795802] 'process raft request' (duration: 199.340216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:35.321085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.940919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210989"} {"level":"info","ts":"2026-04-07T01:40:35.321222Z","caller":"traceutil/trace.go:171","msg":"trace[308056104] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8757; }","duration":"132.141464ms","start":"2026-04-07T01:40:35.189053Z","end":"2026-04-07T01:40:35.321194Z","steps":["trace[308056104] 'range keys from in-memory index tree' (duration: 130.561057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:35.683175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.859243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-04-07T01:40:35.683276Z","caller":"traceutil/trace.go:171","msg":"trace[341930479] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:8759; }","duration":"261.994336ms","start":"2026-04-07T01:40:35.421256Z","end":"2026-04-07T01:40:35.68325Z","steps":["trace[341930479] 'range keys from in-memory index tree' (duration: 261.662216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:35.683286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.561674ms","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-07T01:40:35.683401Z","caller":"traceutil/trace.go:171","msg":"trace[352404607] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8759; }","duration":"217.721178ms","start":"2026-04-07T01:40:35.46565Z","end":"2026-04-07T01:40:35.683371Z","steps":["trace[352404607] 'range keys from in-memory index tree' (duration: 217.274108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:35.683292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.561805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-07T01:40:35.683427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.020117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nwj8g\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-07T01:40:35.683557Z","caller":"traceutil/trace.go:171","msg":"trace[696607881] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8759; }","duration":"217.832841ms","start":"2026-04-07T01:40:35.465655Z","end":"2026-04-07T01:40:35.683488Z","steps":["trace[696607881] 'range keys from in-memory index tree' (duration: 217.38488ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:40:35.683636Z","caller":"traceutil/trace.go:171","msg":"trace[372189398] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nwj8g; range_end:; response_count:1; response_revision:8759; }","duration":"212.229722ms","start":"2026-04-07T01:40:35.471381Z","end":"2026-04-07T01:40:35.68361Z","steps":["trace[372189398] 'range keys from in-memory index tree' (duration: 211.691198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:40:35.683635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.738079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:40:35.683984Z","caller":"traceutil/trace.go:171","msg":"trace[2036882950] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:8759; }","duration":"183.341445ms","start":"2026-04-07T01:40:35.500616Z","end":"2026-04-07T01:40:35.683958Z","steps":["trace[2036882950] 'count revisions from in-memory index tree' (duration: 182.626356ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:40:49.516118Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023f5.wal"} {"level":"info","ts":"2026-04-07T01:41:51.40445Z","caller":"traceutil/trace.go:171","msg":"trace[2076832085] linearizableReadLoop","detail":"{readStateIndex:9836; appliedIndex:9835; }","duration":"220.798096ms","start":"2026-04-07T01:41:51.183625Z","end":"2026-04-07T01:41:51.404423Z","steps":["trace[2076832085] 'read index received' (duration: 220.301524ms)","trace[2076832085] 'applied index is now lower than readState.Index' (duration: 495.492µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:51.404508Z","caller":"traceutil/trace.go:171","msg":"trace[2123322783] transaction","detail":"{read_only:false; response_revision:9501; number_of_response:1; }","duration":"264.373846ms","start":"2026-04-07T01:41:51.140097Z","end":"2026-04-07T01:41:51.404471Z","steps":["trace[2123322783] 'process raft request' (duration: 263.623456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:51.404711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.030702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-07T01:41:51.404794Z","caller":"traceutil/trace.go:171","msg":"trace[182962803] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9501; }","duration":"221.183266ms","start":"2026-04-07T01:41:51.183566Z","end":"2026-04-07T01:41:51.404749Z","steps":["trace[182962803] 'agreement among raft nodes before linearized reading' (duration: 220.96929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:51.598963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.921398ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:41:51.599274Z","caller":"traceutil/trace.go:171","msg":"trace[929973927] transaction","detail":"{read_only:false; response_revision:9502; number_of_response:1; }","duration":"339.887395ms","start":"2026-04-07T01:41:51.259337Z","end":"2026-04-07T01:41:51.599224Z","steps":["trace[929973927] 'process raft request' (duration: 224.615428ms)","trace[929973927] 'compare' (duration: 114.61812ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:41:51.599432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:41:51.259312Z","time spent":"340.038729ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:41:51.599951Z","caller":"traceutil/trace.go:171","msg":"trace[427454041] linearizableReadLoop","detail":"{readStateIndex:9840; appliedIndex:9836; }","duration":"191.166548ms","start":"2026-04-07T01:41:51.408767Z","end":"2026-04-07T01:41:51.599934Z","steps":["trace[427454041] 'read index received' (duration: 74.994736ms)","trace[427454041] 'applied index is now lower than readState.Index' (duration: 116.170622ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:51.600007Z","caller":"traceutil/trace.go:171","msg":"trace[1940536472] transaction","detail":"{read_only:false; response_revision:9503; number_of_response:1; }","duration":"340.260656ms","start":"2026-04-07T01:41:51.259693Z","end":"2026-04-07T01:41:51.599954Z","steps":["trace[1940536472] 'process raft request' (duration: 339.678551ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:51.600081Z","caller":"traceutil/trace.go:171","msg":"trace[15132548] transaction","detail":"{read_only:false; response_revision:9504; number_of_response:1; }","duration":"337.185104ms","start":"2026-04-07T01:41:51.262884Z","end":"2026-04-07T01:41:51.60007Z","steps":["trace[15132548] 'process raft request' (duration: 336.947758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:51.600155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:41:51.26286Z","time spent":"337.253815ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:41:51.600238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:41:51.259684Z","time spent":"340.438481ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:41:51.600283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.519697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-07T01:41:51.600314Z","caller":"traceutil/trace.go:171","msg":"trace[1494591956] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9505; }","duration":"191.572448ms","start":"2026-04-07T01:41:51.408733Z","end":"2026-04-07T01:41:51.600306Z","steps":["trace[1494591956] 'agreement among raft nodes before linearized reading' (duration: 191.454685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:51.600371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.711774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:41:51.600433Z","caller":"traceutil/trace.go:171","msg":"trace[1109054390] transaction","detail":"{read_only:false; response_revision:9505; number_of_response:1; }","duration":"335.042696ms","start":"2026-04-07T01:41:51.265383Z","end":"2026-04-07T01:41:51.600426Z","steps":["trace[1109054390] 'process raft request' (duration: 334.509032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:51.600482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:41:51.265372Z","time spent":"335.085258ms","remote":"127.0.0.1:45220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:41:51.600459Z","caller":"traceutil/trace.go:171","msg":"trace[723447465] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:9505; }","duration":"105.798197ms","start":"2026-04-07T01:41:51.494647Z","end":"2026-04-07T01:41:51.600445Z","steps":["trace[723447465] 'agreement among raft nodes before linearized reading' (duration: 105.686453ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:42:11.676031Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c187bdee547e8fd1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T01:42:11.681803Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T01:42:11.681911Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T01:44:08.088658Z","caller":"traceutil/trace.go:171","msg":"trace[358688036] transaction","detail":"{read_only:false; response_revision:10539; number_of_response:1; }","duration":"113.95475ms","start":"2026-04-07T01:44:07.974662Z","end":"2026-04-07T01:44:08.088617Z","steps":["trace[358688036] 'process raft request' (duration: 113.677242ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:44:25.988158Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8157} {"level":"info","ts":"2026-04-07T01:44:26.055072Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8157,"took":"64.576ms","hash":2345899155,"current-db-size-bytes":57958400,"current-db-size":"58 MB","current-db-size-in-use-bytes":29310976,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-07T01:44:26.055142Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2345899155,"revision":8157,"compact-revision":6044} {"level":"info","ts":"2026-04-07T01:49:25.994139Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10678} {"level":"info","ts":"2026-04-07T01:49:26.077045Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10678,"took":"80.472338ms","hash":1860171629,"current-db-size-bytes":57958400,"current-db-size":"58 MB","current-db-size-in-use-bytes":21860352,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-07T01:49:26.077106Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1860171629,"revision":10678,"compact-revision":8157}