{"level":"warn","ts":"2026-04-06T21:05:02.455662Z","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-06T21:05:02.455748Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70: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-06T21:05:02.455806Z","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-06T21:05:02.455815Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-04-06T21:05:02.45583Z","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-06T21:05:02.456329Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-04-06T21:05:02.4564Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70: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-06T21:05:02.460317Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.720774ms"} {"level":"info","ts":"2026-04-06T21:05:02.468455Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-04-06T21:05:02.468536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-04-06T21:05:02.468561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-04-06T21:05:02.468575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-06T21:05:02.468584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-04-06T21:05:02.468623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-04-06T21:05:02.477296Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-06T21:05:02.481075Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-06T21:05:02.482258Z","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-06T21:05:02.48525Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-06T21:05:02.485774Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-06T21:05:02.485963Z","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-06T21:05:02.486127Z","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-06T21:05:02.486211Z","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-06T21:05:02.487827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-04-06T21:05:02.487982Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-04-06T21:05:02.490808Z","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-06T21:05:02.491005Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-06T21:05:02.491038Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-06T21:05:02.491096Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-04-06T21:05:02.491109Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-04-06T21:05:03.469036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-04-06T21:05:03.469107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-06T21:05:03.46914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-04-06T21:05:03.469155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-04-06T21:05:03.469163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-04-06T21:05:03.469174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-04-06T21:05:03.469192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-04-06T21:05:03.470095Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-04-06T21:05:03.470201Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T21:05:03.470268Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T21:05:03.470304Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:05:03.470626Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-06T21:05:03.470714Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-06T21:05:03.471252Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:05:03.471355Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:05:03.471395Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:05:03.473369Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-04-06T21:05:03.474268Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-06T21:05:23.068789Z","caller":"traceutil/trace.go:171","msg":"trace[465789503] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"172.882333ms","start":"2026-04-06T21:05:22.895865Z","end":"2026-04-06T21:05:23.068747Z","steps":["trace[465789503] 'read index received' (duration: 172.670379ms)","trace[465789503] 'applied index is now lower than readState.Index' (duration: 211.074µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:05:23.06886Z","caller":"traceutil/trace.go:171","msg":"trace[1712503632] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"214.426306ms","start":"2026-04-06T21:05:22.8544Z","end":"2026-04-06T21:05:23.068826Z","steps":["trace[1712503632] 'process raft request' (duration: 214.190491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:23.06897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.078458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:05:23.069066Z","caller":"traceutil/trace.go:171","msg":"trace[1814132312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:410; }","duration":"173.2159ms","start":"2026-04-06T21:05:22.895836Z","end":"2026-04-06T21:05:23.069052Z","steps":["trace[1814132312] 'agreement among raft nodes before linearized reading' (duration: 173.057177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:23.379189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.497025ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:05:23.379385Z","caller":"traceutil/trace.go:171","msg":"trace[728606899] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"306.572847ms","start":"2026-04-06T21:05:23.072775Z","end":"2026-04-06T21:05:23.379347Z","steps":["trace[728606899] 'process raft request' (duration: 117.994967ms)","trace[728606899] 'compare' (duration: 187.410873ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:05:23.379555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:23.072754Z","time spent":"306.715331ms","remote":"127.0.0.1:45080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:05:31.400153Z","caller":"traceutil/trace.go:171","msg":"trace[1673972582] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"130.704967ms","start":"2026-04-06T21:05:31.269423Z","end":"2026-04-06T21:05:31.400128Z","steps":["trace[1673972582] 'process raft request' (duration: 130.586894ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:31.40853Z","caller":"traceutil/trace.go:171","msg":"trace[1058978181] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"130.448931ms","start":"2026-04-06T21:05:31.278062Z","end":"2026-04-06T21:05:31.40851Z","steps":["trace[1058978181] 'process raft request' (duration: 130.278647ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:31.408649Z","caller":"traceutil/trace.go:171","msg":"trace[1180579752] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"130.362659ms","start":"2026-04-06T21:05:31.278257Z","end":"2026-04-06T21:05:31.40862Z","steps":["trace[1180579752] 'process raft request' (duration: 130.167335ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:31.408758Z","caller":"traceutil/trace.go:171","msg":"trace[1029699202] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"123.206575ms","start":"2026-04-06T21:05:31.285516Z","end":"2026-04-06T21:05:31.408723Z","steps":["trace[1029699202] 'process raft request' (duration: 122.94944ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:31.412907Z","caller":"traceutil/trace.go:171","msg":"trace[73746151] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"123.021682ms","start":"2026-04-06T21:05:31.285893Z","end":"2026-04-06T21:05:31.408914Z","steps":["trace[73746151] 'process raft request' (duration: 122.777956ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:31.413015Z","caller":"traceutil/trace.go:171","msg":"trace[428495561] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"124.806032ms","start":"2026-04-06T21:05:31.288088Z","end":"2026-04-06T21:05:31.412894Z","steps":["trace[428495561] 'process raft request' (duration: 120.698079ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:31.41366Z","caller":"traceutil/trace.go:171","msg":"trace[1398730928] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"124.415243ms","start":"2026-04-06T21:05:31.288665Z","end":"2026-04-06T21:05:31.41308Z","steps":["trace[1398730928] 'process raft request' (duration: 120.716479ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:31.413687Z","caller":"traceutil/trace.go:171","msg":"trace[1471062528] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"119.309467ms","start":"2026-04-06T21:05:31.29376Z","end":"2026-04-06T21:05:31.41307Z","steps":["trace[1471062528] 'process raft request' (duration: 117.628679ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:31.413812Z","caller":"traceutil/trace.go:171","msg":"trace[1930363455] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"123.972193ms","start":"2026-04-06T21:05:31.28907Z","end":"2026-04-06T21:05:31.413042Z","steps":["trace[1930363455] 'process raft request' (duration: 120.522205ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:31.413904Z","caller":"traceutil/trace.go:171","msg":"trace[942411604] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"101.76273ms","start":"2026-04-06T21:05:31.312133Z","end":"2026-04-06T21:05:31.413896Z","steps":["trace[942411604] 'process raft request' (duration: 100.793067ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:31.414101Z","caller":"traceutil/trace.go:171","msg":"trace[1220506894] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"117.084997ms","start":"2026-04-06T21:05:31.296124Z","end":"2026-04-06T21:05:31.413209Z","steps":["trace[1220506894] 'process raft request' (duration: 115.50368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:37.741007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.139742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-06T21:05:37.741102Z","caller":"traceutil/trace.go:171","msg":"trace[788052877] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"115.288636ms","start":"2026-04-06T21:05:37.625793Z","end":"2026-04-06T21:05:37.741081Z","steps":["trace[788052877] 'range keys from in-memory index tree' (duration: 114.919768ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:37.84547Z","caller":"traceutil/trace.go:171","msg":"trace[57460639] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"101.568966ms","start":"2026-04-06T21:05:37.743875Z","end":"2026-04-06T21:05:37.845444Z","steps":["trace[57460639] 'process raft request' (duration: 101.420952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:38.125529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.985956ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:05:38.125651Z","caller":"traceutil/trace.go:171","msg":"trace[2036249573] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"381.350434ms","start":"2026-04-06T21:05:37.744282Z","end":"2026-04-06T21:05:38.125632Z","steps":["trace[2036249573] 'process raft request' (duration: 271.181143ms)","trace[2036249573] 'compare' (duration: 109.604157ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:05:38.125715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:37.744254Z","time spent":"381.431666ms","remote":"127.0.0.1:44890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:05:38.63525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.867398ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:05:38.635375Z","caller":"traceutil/trace.go:171","msg":"trace[1889341671] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:575; }","duration":"401.020431ms","start":"2026-04-06T21:05:38.234337Z","end":"2026-04-06T21:05:38.635358Z","steps":["trace[1889341671] 'range keys from in-memory index tree' (duration: 400.849458ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:38.63737Z","caller":"traceutil/trace.go:171","msg":"trace[1341719920] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"468.075062ms","start":"2026-04-06T21:05:38.16928Z","end":"2026-04-06T21:05:38.637355Z","steps":["trace[1341719920] 'process raft request' (duration: 467.940629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:38.637482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:38.169242Z","time spent":"468.180854ms","remote":"127.0.0.1:44996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:05:38.77865Z","caller":"traceutil/trace.go:171","msg":"trace[119905008] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"326.426348ms","start":"2026-04-06T21:05:38.452199Z","end":"2026-04-06T21:05:38.778625Z","steps":["trace[119905008] 'process raft request' (duration: 326.328066ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:38.778762Z","caller":"traceutil/trace.go:171","msg":"trace[734485210] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"592.466296ms","start":"2026-04-06T21:05:38.186261Z","end":"2026-04-06T21:05:38.778728Z","steps":["trace[734485210] 'process raft request' (duration: 591.089374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:38.77885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:38.452169Z","time spent":"326.561652ms","remote":"127.0.0.1:45080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:05:38.778892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:38.186243Z","time spent":"592.585828ms","remote":"127.0.0.1:45054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-06T21:05:38.78953Z","caller":"traceutil/trace.go:171","msg":"trace[815606009] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"110.944458ms","start":"2026-04-06T21:05:38.678532Z","end":"2026-04-06T21:05:38.789477Z","steps":["trace[815606009] 'process raft request' (duration: 110.63149ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:53.502677Z","caller":"traceutil/trace.go:171","msg":"trace[1599277688] linearizableReadLoop","detail":"{readStateIndex:759; appliedIndex:758; }","duration":"253.262378ms","start":"2026-04-06T21:05:53.249378Z","end":"2026-04-06T21:05:53.50264Z","steps":["trace[1599277688] 'read index received' (duration: 253.089703ms)","trace[1599277688] 'applied index is now lower than readState.Index' (duration: 170.705µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:05:53.502874Z","caller":"traceutil/trace.go:171","msg":"trace[2087508408] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"255.701479ms","start":"2026-04-06T21:05:53.247051Z","end":"2026-04-06T21:05:53.502752Z","steps":["trace[2087508408] 'process raft request' (duration: 255.431511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:53.502976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.580077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-b58bt\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-06T21:05:53.503037Z","caller":"traceutil/trace.go:171","msg":"trace[745152329] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-b58bt; range_end:; response_count:1; response_revision:730; }","duration":"253.713281ms","start":"2026-04-06T21:05:53.249308Z","end":"2026-04-06T21:05:53.503021Z","steps":["trace[745152329] 'agreement among raft nodes before linearized reading' (duration: 253.465664ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:20.577285Z","caller":"traceutil/trace.go:171","msg":"trace[344666255] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"137.481756ms","start":"2026-04-06T21:06:20.43977Z","end":"2026-04-06T21:06:20.577252Z","steps":["trace[344666255] 'process raft request' (duration: 137.239551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:07:07.186803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.350024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3986691c-eab2-4a81-8e72-03a922ea2aca\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-06T21:07:07.186911Z","caller":"traceutil/trace.go:171","msg":"trace[1299697394] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3986691c-eab2-4a81-8e72-03a922ea2aca; range_end:; response_count:1; response_revision:1799; }","duration":"176.522198ms","start":"2026-04-06T21:07:07.010363Z","end":"2026-04-06T21:07:07.186885Z","steps":["trace[1299697394] 'range keys from in-memory index tree' (duration: 176.123189ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:07.3796Z","caller":"traceutil/trace.go:171","msg":"trace[1676995243] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"290.728195ms","start":"2026-04-06T21:07:07.08884Z","end":"2026-04-06T21:07:07.379568Z","steps":["trace[1676995243] 'process raft request' (duration: 290.536761ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:07.433099Z","caller":"traceutil/trace.go:171","msg":"trace[745291586] linearizableReadLoop","detail":"{readStateIndex:1873; appliedIndex:1871; }","duration":"205.205528ms","start":"2026-04-06T21:07:07.227873Z","end":"2026-04-06T21:07:07.433079Z","steps":["trace[745291586] 'read index received' (duration: 151.573121ms)","trace[745291586] 'applied index is now lower than readState.Index' (duration: 53.631446ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:07:07.433343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.442174ms","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-06T21:07:07.433279Z","caller":"traceutil/trace.go:171","msg":"trace[1281457317] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"234.8894ms","start":"2026-04-06T21:07:07.19835Z","end":"2026-04-06T21:07:07.43324Z","steps":["trace[1281457317] 'process raft request' (duration: 197.363352ms)","trace[1281457317] 'compare' (duration: 37.278852ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:07:07.433481Z","caller":"traceutil/trace.go:171","msg":"trace[900921793] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1801; }","duration":"205.592976ms","start":"2026-04-06T21:07:07.227843Z","end":"2026-04-06T21:07:07.433436Z","steps":["trace[900921793] 'agreement among raft nodes before linearized reading' (duration: 205.403202ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:07.807373Z","caller":"traceutil/trace.go:171","msg":"trace[971224498] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"190.403667ms","start":"2026-04-06T21:07:07.616944Z","end":"2026-04-06T21:07:07.807348Z","steps":["trace[971224498] 'process raft request' (duration: 190.253044ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:20.646529Z","caller":"traceutil/trace.go:171","msg":"trace[1358101850] linearizableReadLoop","detail":"{readStateIndex:1986; appliedIndex:1985; }","duration":"130.805428ms","start":"2026-04-06T21:07:20.515694Z","end":"2026-04-06T21:07:20.646499Z","steps":["trace[1358101850] 'read index received' (duration: 122.335329ms)","trace[1358101850] 'applied index is now lower than readState.Index' (duration: 8.468849ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:07:20.64661Z","caller":"traceutil/trace.go:171","msg":"trace[116817429] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"205.310179ms","start":"2026-04-06T21:07:20.441267Z","end":"2026-04-06T21:07:20.646577Z","steps":["trace[116817429] 'process raft request' (duration: 196.859671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:07:20.646791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.081903ms","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-06T21:07:20.646854Z","caller":"traceutil/trace.go:171","msg":"trace[1689924026] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1910; }","duration":"131.197486ms","start":"2026-04-06T21:07:20.515641Z","end":"2026-04-06T21:07:20.646838Z","steps":["trace[1689924026] 'agreement among raft nodes before linearized reading' (duration: 130.979671ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:56.975082Z","caller":"traceutil/trace.go:171","msg":"trace[1137634292] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"135.526253ms","start":"2026-04-06T21:07:56.839517Z","end":"2026-04-06T21:07:56.975044Z","steps":["trace[1137634292] 'process raft request' (duration: 112.893958ms)","trace[1137634292] 'compare' (duration: 22.42827ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:07:57.141489Z","caller":"traceutil/trace.go:171","msg":"trace[1817966714] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"108.237725ms","start":"2026-04-06T21:07:57.033228Z","end":"2026-04-06T21:07:57.141465Z","steps":["trace[1817966714] 'process raft request' (duration: 52.921252ms)","trace[1817966714] 'compare' (duration: 55.180211ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:07:57.751284Z","caller":"traceutil/trace.go:171","msg":"trace[2129230768] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"137.69707ms","start":"2026-04-06T21:07:57.613559Z","end":"2026-04-06T21:07:57.751256Z","steps":["trace[2129230768] 'process raft request' (duration: 137.561108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:03.641528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.47555ms","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-06T21:08:03.641675Z","caller":"traceutil/trace.go:171","msg":"trace[403034866] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2154; }","duration":"336.674274ms","start":"2026-04-06T21:08:03.304965Z","end":"2026-04-06T21:08:03.641639Z","steps":["trace[403034866] 'range keys from in-memory index tree' (duration: 336.223076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:03.64174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:08:03.304944Z","time spent":"336.779105ms","remote":"127.0.0.1:60894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-06T21:08:36.605451Z","caller":"traceutil/trace.go:171","msg":"trace[1322712530] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"240.866129ms","start":"2026-04-06T21:08:36.36454Z","end":"2026-04-06T21:08:36.605406Z","steps":["trace[1322712530] 'process raft request' (duration: 239.275073ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:08:36.744204Z","caller":"traceutil/trace.go:171","msg":"trace[377773379] linearizableReadLoop","detail":"{readStateIndex:2606; appliedIndex:2604; }","duration":"362.384647ms","start":"2026-04-06T21:08:36.38179Z","end":"2026-04-06T21:08:36.744174Z","steps":["trace[377773379] 'read index received' (duration: 222.100173ms)","trace[377773379] 'applied index is now lower than readState.Index' (duration: 140.283234ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:08:36.744218Z","caller":"traceutil/trace.go:171","msg":"trace[1669737692] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"376.943563ms","start":"2026-04-06T21:08:36.367241Z","end":"2026-04-06T21:08:36.744184Z","steps":["trace[1669737692] 'process raft request' (duration: 360.652708ms)","trace[1669737692] 'compare' (duration: 16.127752ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:08:36.744419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.608461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-06T21:08:36.74443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:08:36.367235Z","time spent":"377.102035ms","remote":"127.0.0.1:45080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:08:36.744469Z","caller":"traceutil/trace.go:171","msg":"trace[375987040] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:2508; }","duration":"362.714293ms","start":"2026-04-06T21:08:36.381742Z","end":"2026-04-06T21:08:36.744457Z","steps":["trace[375987040] 'agreement among raft nodes before linearized reading' (duration: 362.54068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:36.744505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:08:36.381724Z","time spent":"362.773664ms","remote":"127.0.0.1:44840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.70\" "} {"level":"warn","ts":"2026-04-06T21:08:36.744594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.187894ms","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-06T21:08:36.744711Z","caller":"traceutil/trace.go:171","msg":"trace[434186425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2508; }","duration":"340.382007ms","start":"2026-04-06T21:08:36.404302Z","end":"2026-04-06T21:08:36.744684Z","steps":["trace[434186425] 'agreement among raft nodes before linearized reading' (duration: 340.054541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:36.744773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:08:36.40427Z","time spent":"340.485318ms","remote":"127.0.0.1:45080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-06T21:09:11.175703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.773141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-06T21:09:11.175797Z","caller":"traceutil/trace.go:171","msg":"trace[1014841491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2714; }","duration":"167.942964ms","start":"2026-04-06T21:09:11.007834Z","end":"2026-04-06T21:09:11.175777Z","steps":["trace[1014841491] 'range keys from in-memory index tree' (duration: 167.537975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:09:11.176007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.964325ms","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-06T21:09:11.176127Z","caller":"traceutil/trace.go:171","msg":"trace[1850443195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2714; }","duration":"247.138489ms","start":"2026-04-06T21:09:10.928959Z","end":"2026-04-06T21:09:11.176098Z","steps":["trace[1850443195] 'range keys from in-memory index tree' (duration: 246.75917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:09:11.176239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.249752ms","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-06T21:09:11.176277Z","caller":"traceutil/trace.go:171","msg":"trace[1618163503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2714; }","duration":"251.346984ms","start":"2026-04-06T21:09:10.92492Z","end":"2026-04-06T21:09:11.176267Z","steps":["trace[1618163503] 'range keys from in-memory index tree' (duration: 251.072598ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:09:11.419798Z","caller":"traceutil/trace.go:171","msg":"trace[566597029] transaction","detail":"{read_only:false; response_revision:2716; number_of_response:1; }","duration":"238.484077ms","start":"2026-04-06T21:09:11.181264Z","end":"2026-04-06T21:09:11.419748Z","steps":["trace[566597029] 'process raft request' (duration: 238.069557ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:09:11.419862Z","caller":"traceutil/trace.go:171","msg":"trace[362566188] transaction","detail":"{read_only:false; response_revision:2718; number_of_response:1; }","duration":"236.138734ms","start":"2026-04-06T21:09:11.18368Z","end":"2026-04-06T21:09:11.419818Z","steps":["trace[362566188] 'process raft request' (duration: 235.833537ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:09:11.419916Z","caller":"traceutil/trace.go:171","msg":"trace[694060335] transaction","detail":"{read_only:false; response_revision:2717; number_of_response:1; }","duration":"236.226346ms","start":"2026-04-06T21:09:11.183639Z","end":"2026-04-06T21:09:11.419865Z","steps":["trace[694060335] 'process raft request' (duration: 235.845688ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:10.82119Z","caller":"traceutil/trace.go:171","msg":"trace[1597765998] linearizableReadLoop","detail":"{readStateIndex:5086; appliedIndex:5085; }","duration":"338.203024ms","start":"2026-04-06T21:13:10.482957Z","end":"2026-04-06T21:13:10.82116Z","steps":["trace[1597765998] 'read index received' (duration: 338.037669ms)","trace[1597765998] 'applied index is now lower than readState.Index' (duration: 163.905µs)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:13:10.821545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.531102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:13:10.821772Z","caller":"traceutil/trace.go:171","msg":"trace[1733525347] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:4896; }","duration":"338.833588ms","start":"2026-04-06T21:13:10.482893Z","end":"2026-04-06T21:13:10.821727Z","steps":["trace[1733525347] 'agreement among raft nodes before linearized reading' (duration: 338.43247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:13:10.821881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:13:10.482868Z","time spent":"338.991631ms","remote":"127.0.0.1:45018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/monitoring/vector\" "} {"level":"info","ts":"2026-04-06T21:13:10.821295Z","caller":"traceutil/trace.go:171","msg":"trace[687918484] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"345.64301ms","start":"2026-04-06T21:13:10.475625Z","end":"2026-04-06T21:13:10.821268Z","steps":["trace[687918484] 'process raft request' (duration: 345.345433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:13:10.822923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:13:10.475611Z","time spent":"347.212025ms","remote":"127.0.0.1:44996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3702,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:13:10.839721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.410601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-06T21:13:10.839733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.401986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-06T21:13:10.839793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.746482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c9655d76-0003-4fd9-97d0-0dba4266b11b\" ","response":"range_response_count:1 size:3717"} {"level":"warn","ts":"2026-04-06T21:13:10.839809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.389905ms","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-06T21:13:10.839832Z","caller":"traceutil/trace.go:171","msg":"trace[2026870985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4897; }","duration":"234.551329ms","start":"2026-04-06T21:13:10.605256Z","end":"2026-04-06T21:13:10.839808Z","steps":["trace[2026870985] 'agreement among raft nodes before linearized reading' (duration: 234.299023ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:10.839869Z","caller":"traceutil/trace.go:171","msg":"trace[1708924131] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c9655d76-0003-4fd9-97d0-0dba4266b11b; range_end:; response_count:1; response_revision:4897; }","duration":"285.859755ms","start":"2026-04-06T21:13:10.553992Z","end":"2026-04-06T21:13:10.839851Z","steps":["trace[1708924131] 'agreement among raft nodes before linearized reading' (duration: 285.718042ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:10.839876Z","caller":"traceutil/trace.go:171","msg":"trace[1041284341] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4897; }","duration":"234.484008ms","start":"2026-04-06T21:13:10.605376Z","end":"2026-04-06T21:13:10.83986Z","steps":["trace[1041284341] 'agreement among raft nodes before linearized reading' (duration: 234.248033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:13:10.839824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.716112ms","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-06T21:13:10.839777Z","caller":"traceutil/trace.go:171","msg":"trace[1123104407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4897; }","duration":"232.491093ms","start":"2026-04-06T21:13:10.607273Z","end":"2026-04-06T21:13:10.839764Z","steps":["trace[1123104407] 'agreement among raft nodes before linearized reading' (duration: 232.257178ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:10.839948Z","caller":"traceutil/trace.go:171","msg":"trace[2081109320] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4897; }","duration":"238.924646ms","start":"2026-04-06T21:13:10.600996Z","end":"2026-04-06T21:13:10.839921Z","steps":["trace[2081109320] 'agreement among raft nodes before linearized reading' (duration: 238.554598ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:11.165738Z","caller":"traceutil/trace.go:171","msg":"trace[1180432874] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"142.734627ms","start":"2026-04-06T21:13:11.022966Z","end":"2026-04-06T21:13:11.1657Z","steps":["trace[1180432874] 'process raft request' (duration: 84.297623ms)","trace[1180432874] 'compare' (duration: 58.149938ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:13:18.738447Z","caller":"traceutil/trace.go:171","msg":"trace[1809233308] linearizableReadLoop","detail":"{readStateIndex:5260; appliedIndex:5259; }","duration":"159.450621ms","start":"2026-04-06T21:13:18.578969Z","end":"2026-04-06T21:13:18.73842Z","steps":["trace[1809233308] 'read index received' (duration: 159.278847ms)","trace[1809233308] 'applied index is now lower than readState.Index' (duration: 170.644µs)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:13:18.73873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.740307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-06T21:13:18.738823Z","caller":"traceutil/trace.go:171","msg":"trace[1243724884] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5064; }","duration":"159.84804ms","start":"2026-04-06T21:13:18.578948Z","end":"2026-04-06T21:13:18.738796Z","steps":["trace[1243724884] 'agreement among raft nodes before linearized reading' (duration: 159.583325ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:18.739188Z","caller":"traceutil/trace.go:171","msg":"trace[788129692] transaction","detail":"{read_only:false; response_revision:5064; number_of_response:1; }","duration":"161.422996ms","start":"2026-04-06T21:13:18.577743Z","end":"2026-04-06T21:13:18.739166Z","steps":["trace[788129692] 'process raft request' (duration: 160.511806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:13:18.749184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.578793ms","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":"info","ts":"2026-04-06T21:13:18.749293Z","caller":"traceutil/trace.go:171","msg":"trace[629596663] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5065; }","duration":"167.729936ms","start":"2026-04-06T21:13:18.581548Z","end":"2026-04-06T21:13:18.749278Z","steps":["trace[629596663] 'agreement among raft nodes before linearized reading' (duration: 167.530282ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:22.311968Z","caller":"traceutil/trace.go:171","msg":"trace[67293193] linearizableReadLoop","detail":"{readStateIndex:5329; appliedIndex:5328; }","duration":"188.511793ms","start":"2026-04-06T21:13:22.123435Z","end":"2026-04-06T21:13:22.311947Z","steps":["trace[67293193] 'read index received' (duration: 188.355249ms)","trace[67293193] 'applied index is now lower than readState.Index' (duration: 155.734µs)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:13:22.312259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.803459ms","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-06T21:13:22.312323Z","caller":"traceutil/trace.go:171","msg":"trace[515431996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5130; }","duration":"188.903321ms","start":"2026-04-06T21:13:22.123379Z","end":"2026-04-06T21:13:22.312283Z","steps":["trace[515431996] 'agreement among raft nodes before linearized reading' (duration: 188.657696ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:22.312612Z","caller":"traceutil/trace.go:171","msg":"trace[342572781] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"193.126456ms","start":"2026-04-06T21:13:22.119472Z","end":"2026-04-06T21:13:22.312598Z","steps":["trace[342572781] 'process raft request' (duration: 192.327278ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:22.441728Z","caller":"traceutil/trace.go:171","msg":"trace[1246501091] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"124.726194ms","start":"2026-04-06T21:13:22.316961Z","end":"2026-04-06T21:13:22.441687Z","steps":["trace[1246501091] 'process raft request' (duration: 124.496789ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:29.867021Z","caller":"traceutil/trace.go:171","msg":"trace[1900174239] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"146.115629ms","start":"2026-04-06T21:13:29.720876Z","end":"2026-04-06T21:13:29.866992Z","steps":["trace[1900174239] 'process raft request' (duration: 61.322474ms)","trace[1900174239] 'compare' (duration: 84.644672ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:13:30.445321Z","caller":"traceutil/trace.go:171","msg":"trace[31233646] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"105.825443ms","start":"2026-04-06T21:13:30.339452Z","end":"2026-04-06T21:13:30.445277Z","steps":["trace[31233646] 'process raft request' (duration: 105.073696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:21.756326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.196416ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-06T21:15:03.499228Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3001} {"level":"info","ts":"2026-04-06T21:15:03.59803Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3001,"took":"96.647622ms","hash":3575386988,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":31469568,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-06T21:15:03.598088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3575386988,"revision":3001,"compact-revision":-1} {"level":"info","ts":"2026-04-06T21:19:36.617368Z","caller":"traceutil/trace.go:171","msg":"trace[283101684] transaction","detail":"{read_only:false; response_revision:8134; number_of_response:1; }","duration":"135.182852ms","start":"2026-04-06T21:19:36.482007Z","end":"2026-04-06T21:19:36.617189Z","steps":["trace[283101684] 'process raft request' (duration: 134.457066ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:47.339092Z","caller":"traceutil/trace.go:171","msg":"trace[1630579303] transaction","detail":"{read_only:false; response_revision:8194; number_of_response:1; }","duration":"208.373174ms","start":"2026-04-06T21:19:47.130158Z","end":"2026-04-06T21:19:47.338531Z","steps":["trace[1630579303] 'process raft request' (duration: 208.182769ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:47.377491Z","caller":"traceutil/trace.go:171","msg":"trace[1596543569] linearizableReadLoop","detail":"{readStateIndex:8489; appliedIndex:8486; }","duration":"180.721488ms","start":"2026-04-06T21:19:47.196748Z","end":"2026-04-06T21:19:47.377469Z","steps":["trace[1596543569] 'read index received' (duration: 141.65376ms)","trace[1596543569] 'applied index is now lower than readState.Index' (duration: 39.066828ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:19:47.377525Z","caller":"traceutil/trace.go:171","msg":"trace[1150337139] transaction","detail":"{read_only:false; response_revision:8195; number_of_response:1; }","duration":"247.280978ms","start":"2026-04-06T21:19:47.13023Z","end":"2026-04-06T21:19:47.377511Z","steps":["trace[1150337139] 'process raft request' (duration: 247.081024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:19:47.377607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.853211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:19:47.377596Z","caller":"traceutil/trace.go:171","msg":"trace[1681371473] transaction","detail":"{read_only:false; response_revision:8196; number_of_response:1; }","duration":"247.236827ms","start":"2026-04-06T21:19:47.130323Z","end":"2026-04-06T21:19:47.37756Z","steps":["trace[1681371473] 'process raft request' (duration: 247.108284ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:47.377645Z","caller":"traceutil/trace.go:171","msg":"trace[1370353425] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8196; }","duration":"180.921463ms","start":"2026-04-06T21:19:47.196706Z","end":"2026-04-06T21:19:47.377627Z","steps":["trace[1370353425] 'agreement among raft nodes before linearized reading' (duration: 180.855351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:19:47.377836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.644789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wb5c6\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-06T21:19:47.377892Z","caller":"traceutil/trace.go:171","msg":"trace[25513776] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wb5c6; range_end:; response_count:1; response_revision:8196; }","duration":"118.73538ms","start":"2026-04-06T21:19:47.259143Z","end":"2026-04-06T21:19:47.377878Z","steps":["trace[25513776] 'agreement among raft nodes before linearized reading' (duration: 118.553886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:19:47.684084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.300823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-06T21:19:47.684212Z","caller":"traceutil/trace.go:171","msg":"trace[277281147] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8196; }","duration":"289.458886ms","start":"2026-04-06T21:19:47.394728Z","end":"2026-04-06T21:19:47.684187Z","steps":["trace[277281147] 'range keys from in-memory index tree' (duration: 289.140169ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:49.219205Z","caller":"traceutil/trace.go:171","msg":"trace[1624519853] linearizableReadLoop","detail":"{readStateIndex:8495; appliedIndex:8494; }","duration":"176.25286ms","start":"2026-04-06T21:19:49.042926Z","end":"2026-04-06T21:19:49.219179Z","steps":["trace[1624519853] 'read index received' (duration: 176.092256ms)","trace[1624519853] 'applied index is now lower than readState.Index' (duration: 159.483µs)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:19:49.219407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.412453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:19:49.219535Z","caller":"traceutil/trace.go:171","msg":"trace[1906140230] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:8202; }","duration":"176.630288ms","start":"2026-04-06T21:19:49.04288Z","end":"2026-04-06T21:19:49.21951Z","steps":["trace[1906140230] 'agreement among raft nodes before linearized reading' (duration: 176.411433ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:49.21939Z","caller":"traceutil/trace.go:171","msg":"trace[997544125] transaction","detail":"{read_only:false; response_revision:8202; number_of_response:1; }","duration":"182.524139ms","start":"2026-04-06T21:19:49.03674Z","end":"2026-04-06T21:19:49.219264Z","steps":["trace[997544125] 'process raft request' (duration: 182.262254ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:50.066993Z","caller":"traceutil/trace.go:171","msg":"trace[1110843436] transaction","detail":"{read_only:false; response_revision:8206; number_of_response:1; }","duration":"156.395207ms","start":"2026-04-06T21:19:49.910564Z","end":"2026-04-06T21:19:50.06696Z","steps":["trace[1110843436] 'process raft request' (duration: 156.201873ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:50.069746Z","caller":"traceutil/trace.go:171","msg":"trace[1001471066] transaction","detail":"{read_only:false; response_revision:8207; number_of_response:1; }","duration":"140.999455ms","start":"2026-04-06T21:19:49.928735Z","end":"2026-04-06T21:19:50.069734Z","steps":["trace[1001471066] 'process raft request' (duration: 140.938653ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:03.505375Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6110} {"level":"info","ts":"2026-04-06T21:20:03.605427Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6110,"took":"98.01287ms","hash":1853377418,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":22917120,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-06T21:20:03.605498Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1853377418,"revision":6110,"compact-revision":3001} {"level":"info","ts":"2026-04-06T21:20:14.05718Z","caller":"traceutil/trace.go:171","msg":"trace[1078013805] transaction","detail":"{read_only:false; response_revision:8386; number_of_response:1; }","duration":"123.301962ms","start":"2026-04-06T21:20:13.933843Z","end":"2026-04-06T21:20:14.057145Z","steps":["trace[1078013805] 'process raft request' (duration: 122.7749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:18.161831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.421522ms","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-06T21:20:18.161912Z","caller":"traceutil/trace.go:171","msg":"trace[144206506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8410; }","duration":"623.542514ms","start":"2026-04-06T21:20:17.538348Z","end":"2026-04-06T21:20:18.161891Z","steps":["trace[144206506] 'range keys from in-memory index tree' (duration: 623.254929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:18.161956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:17.538331Z","time spent":"623.615386ms","remote":"127.0.0.1:45080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-06T21:20:18.162194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.56603ms","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-06T21:20:18.162291Z","caller":"traceutil/trace.go:171","msg":"trace[148326388] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8410; }","duration":"647.697692ms","start":"2026-04-06T21:20:17.514568Z","end":"2026-04-06T21:20:18.162265Z","steps":["trace[148326388] 'range keys from in-memory index tree' (duration: 647.405286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:18.162342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:17.514521Z","time spent":"647.807956ms","remote":"127.0.0.1:45080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-06T21:20:18.162687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.862119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-06T21:20:18.162803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.903536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wb5c6\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-06T21:20:18.162858Z","caller":"traceutil/trace.go:171","msg":"trace[1107376141] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wb5c6; range_end:; response_count:1; response_revision:8410; }","duration":"530.985067ms","start":"2026-04-06T21:20:17.631859Z","end":"2026-04-06T21:20:18.162844Z","steps":["trace[1107376141] 'range keys from in-memory index tree' (duration: 530.778402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:18.162864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.491012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:18.162891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:17.631844Z","time spent":"531.038959ms","remote":"127.0.0.1:44996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-wb5c6\" "} {"level":"info","ts":"2026-04-06T21:20:18.162959Z","caller":"traceutil/trace.go:171","msg":"trace[448869463] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:8410; }","duration":"671.643115ms","start":"2026-04-06T21:20:17.491294Z","end":"2026-04-06T21:20:18.162937Z","steps":["trace[448869463] 'count revisions from in-memory index tree' (duration: 671.313717ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:18.162868Z","caller":"traceutil/trace.go:171","msg":"trace[664688171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8410; }","duration":"591.054303ms","start":"2026-04-06T21:20:17.571736Z","end":"2026-04-06T21:20:18.16279Z","steps":["trace[664688171] 'range keys from in-memory index tree' (duration: 590.642044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:18.16309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:17.571709Z","time spent":"591.344759ms","remote":"127.0.0.1:45080","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":"warn","ts":"2026-04-06T21:20:18.163014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:17.49127Z","time spent":"671.733596ms","remote":"127.0.0.1:45210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-06T21:20:18.163436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.779655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:18.163478Z","caller":"traceutil/trace.go:171","msg":"trace[1288437602] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8410; }","duration":"267.855877ms","start":"2026-04-06T21:20:17.895611Z","end":"2026-04-06T21:20:18.163467Z","steps":["trace[1288437602] 'range keys from in-memory index tree' (duration: 267.710574ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:20.317886Z","caller":"traceutil/trace.go:171","msg":"trace[827090717] linearizableReadLoop","detail":"{readStateIndex:8722; appliedIndex:8721; }","duration":"126.792199ms","start":"2026-04-06T21:20:20.191069Z","end":"2026-04-06T21:20:20.317861Z","steps":["trace[827090717] 'read index received' (duration: 126.592525ms)","trace[827090717] 'applied index is now lower than readState.Index' (duration: 195.344µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:20.318011Z","caller":"traceutil/trace.go:171","msg":"trace[138269766] transaction","detail":"{read_only:false; response_revision:8420; number_of_response:1; }","duration":"126.973713ms","start":"2026-04-06T21:20:20.190987Z","end":"2026-04-06T21:20:20.317961Z","steps":["trace[138269766] 'process raft request' (duration: 126.709948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:20.318127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.039314ms","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-06T21:20:20.318207Z","caller":"traceutil/trace.go:171","msg":"trace[1417098700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8420; }","duration":"127.164767ms","start":"2026-04-06T21:20:20.191024Z","end":"2026-04-06T21:20:20.318189Z","steps":["trace[1417098700] 'agreement among raft nodes before linearized reading' (duration: 126.931342ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:20.349637Z","caller":"traceutil/trace.go:171","msg":"trace[1266026058] transaction","detail":"{read_only:false; response_revision:8421; number_of_response:1; }","duration":"157.539203ms","start":"2026-04-06T21:20:20.192072Z","end":"2026-04-06T21:20:20.349612Z","steps":["trace[1266026058] 'process raft request' (duration: 157.333008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:20.349729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.125026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-06T21:20:20.349784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.454244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wb5c6\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-04-06T21:20:20.34983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.86178ms","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-06T21:20:20.349855Z","caller":"traceutil/trace.go:171","msg":"trace[1059543175] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wb5c6; range_end:; response_count:1; response_revision:8421; }","duration":"154.555998ms","start":"2026-04-06T21:20:20.195287Z","end":"2026-04-06T21:20:20.349843Z","steps":["trace[1059543175] 'agreement among raft nodes before linearized reading' (duration: 154.351372ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:20.349892Z","caller":"traceutil/trace.go:171","msg":"trace[935032285] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8421; }","duration":"157.952473ms","start":"2026-04-06T21:20:20.191926Z","end":"2026-04-06T21:20:20.349879Z","steps":["trace[935032285] 'agreement among raft nodes before linearized reading' (duration: 157.750137ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:20.34981Z","caller":"traceutil/trace.go:171","msg":"trace[180864983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8421; }","duration":"158.222137ms","start":"2026-04-06T21:20:20.191549Z","end":"2026-04-06T21:20:20.349771Z","steps":["trace[180864983] 'agreement among raft nodes before linearized reading' (duration: 158.051033ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:20.470272Z","caller":"traceutil/trace.go:171","msg":"trace[1214832772] linearizableReadLoop","detail":"{readStateIndex:8724; appliedIndex:8723; }","duration":"116.195323ms","start":"2026-04-06T21:20:20.354055Z","end":"2026-04-06T21:20:20.470251Z","steps":["trace[1214832772] 'read index received' (duration: 111.785996ms)","trace[1214832772] 'applied index is now lower than readState.Index' (duration: 4.408337ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:20.470377Z","caller":"traceutil/trace.go:171","msg":"trace[543440771] transaction","detail":"{read_only:false; response_revision:8422; number_of_response:1; }","duration":"147.778366ms","start":"2026-04-06T21:20:20.322563Z","end":"2026-04-06T21:20:20.470341Z","steps":["trace[543440771] 'process raft request' (duration: 143.412669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:20.470731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.657964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228841"} {"level":"info","ts":"2026-04-06T21:20:20.470811Z","caller":"traceutil/trace.go:171","msg":"trace[1120644638] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8422; }","duration":"116.776057ms","start":"2026-04-06T21:20:20.354018Z","end":"2026-04-06T21:20:20.470794Z","steps":["trace[1120644638] 'agreement among raft nodes before linearized reading' (duration: 116.330737ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:20.485773Z","caller":"traceutil/trace.go:171","msg":"trace[985824242] transaction","detail":"{read_only:false; response_revision:8424; number_of_response:1; }","duration":"131.208908ms","start":"2026-04-06T21:20:20.354532Z","end":"2026-04-06T21:20:20.48574Z","steps":["trace[985824242] 'process raft request' (duration: 131.159027ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:20.485849Z","caller":"traceutil/trace.go:171","msg":"trace[348099673] transaction","detail":"{read_only:false; response_revision:8423; number_of_response:1; }","duration":"131.536585ms","start":"2026-04-06T21:20:20.354284Z","end":"2026-04-06T21:20:20.485821Z","steps":["trace[348099673] 'process raft request' (duration: 131.253198ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.062433Z","caller":"traceutil/trace.go:171","msg":"trace[1398387522] linearizableReadLoop","detail":"{readStateIndex:8728; appliedIndex:8727; }","duration":"198.30088ms","start":"2026-04-06T21:20:20.864105Z","end":"2026-04-06T21:20:21.062405Z","steps":["trace[1398387522] 'read index received' (duration: 123.087397ms)","trace[1398387522] 'applied index is now lower than readState.Index' (duration: 75.212133ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:21.062597Z","caller":"traceutil/trace.go:171","msg":"trace[1920035902] transaction","detail":"{read_only:false; response_revision:8426; number_of_response:1; }","duration":"252.488564ms","start":"2026-04-06T21:20:20.810094Z","end":"2026-04-06T21:20:21.062583Z","steps":["trace[1920035902] 'process raft request' (duration: 177.154289ms)","trace[1920035902] 'compare' (duration: 75.028598ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:20:21.062726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.660226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.06283Z","caller":"traceutil/trace.go:171","msg":"trace[1955428746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8426; }","duration":"166.80567ms","start":"2026-04-06T21:20:20.895999Z","end":"2026-04-06T21:20:21.062804Z","steps":["trace[1955428746] 'agreement among raft nodes before linearized reading' (duration: 166.659687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.063224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.111178ms","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-06T21:20:21.063274Z","caller":"traceutil/trace.go:171","msg":"trace[1035476690] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8426; }","duration":"199.194939ms","start":"2026-04-06T21:20:20.864065Z","end":"2026-04-06T21:20:21.06326Z","steps":["trace[1035476690] 'agreement among raft nodes before linearized reading' (duration: 199.009525ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.518854Z","caller":"traceutil/trace.go:171","msg":"trace[415076173] linearizableReadLoop","detail":"{readStateIndex:8729; appliedIndex:8728; }","duration":"138.531031ms","start":"2026-04-06T21:20:21.380295Z","end":"2026-04-06T21:20:21.518826Z","steps":["trace[415076173] 'read index received' (duration: 138.256895ms)","trace[415076173] 'applied index is now lower than readState.Index' (duration: 272.516µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:21.518968Z","caller":"traceutil/trace.go:171","msg":"trace[1957726487] transaction","detail":"{read_only:false; response_revision:8427; number_of_response:1; }","duration":"451.164872ms","start":"2026-04-06T21:20:21.067763Z","end":"2026-04-06T21:20:21.518928Z","steps":["trace[1957726487] 'process raft request' (duration: 450.857916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.519126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.822597ms","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-06T21:20:21.519195Z","caller":"traceutil/trace.go:171","msg":"trace[952620540] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8427; }","duration":"138.92935ms","start":"2026-04-06T21:20:21.380253Z","end":"2026-04-06T21:20:21.519182Z","steps":["trace[952620540] 'agreement among raft nodes before linearized reading' (duration: 138.688395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.519134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:21.067742Z","time spent":"451.281714ms","remote":"127.0.0.1:45080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:20:21.644173Z","caller":"traceutil/trace.go:171","msg":"trace[522924515] transaction","detail":"{read_only:false; response_revision:8428; number_of_response:1; }","duration":"121.023572ms","start":"2026-04-06T21:20:21.523124Z","end":"2026-04-06T21:20:21.644147Z","steps":["trace[522924515] 'process raft request' (duration: 111.320306ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:30.903802Z","caller":"traceutil/trace.go:171","msg":"trace[846962351] transaction","detail":"{read_only:false; response_revision:8522; number_of_response:1; }","duration":"164.811335ms","start":"2026-04-06T21:20:30.738962Z","end":"2026-04-06T21:20:30.903773Z","steps":["trace[846962351] 'process raft request' (duration: 164.508538ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:31.829464Z","caller":"traceutil/trace.go:171","msg":"trace[636620816] linearizableReadLoop","detail":"{readStateIndex:8838; appliedIndex:8837; }","duration":"150.172518ms","start":"2026-04-06T21:20:31.679258Z","end":"2026-04-06T21:20:31.829431Z","steps":["trace[636620816] 'read index received' (duration: 149.819771ms)","trace[636620816] 'applied index is now lower than readState.Index' (duration: 350.197µs)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:20:31.82972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.444875ms","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-06T21:20:31.829576Z","caller":"traceutil/trace.go:171","msg":"trace[1287892469] transaction","detail":"{read_only:false; response_revision:8530; number_of_response:1; }","duration":"215.760268ms","start":"2026-04-06T21:20:31.613783Z","end":"2026-04-06T21:20:31.829544Z","steps":["trace[1287892469] 'process raft request' (duration: 215.39642ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:31.829783Z","caller":"traceutil/trace.go:171","msg":"trace[1473337075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8530; }","duration":"150.578078ms","start":"2026-04-06T21:20:31.679187Z","end":"2026-04-06T21:20:31.829765Z","steps":["trace[1473337075] 'agreement among raft nodes before linearized reading' (duration: 150.365753ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:21:22.103121Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000248a.wal"} {"level":"info","ts":"2026-04-06T21:21:35.05252Z","caller":"traceutil/trace.go:171","msg":"trace[1792105978] transaction","detail":"{read_only:false; response_revision:9196; number_of_response:1; }","duration":"102.99038ms","start":"2026-04-06T21:21:34.949497Z","end":"2026-04-06T21:21:35.052487Z","steps":["trace[1792105978] 'process raft request' (duration: 102.766845ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:21:35.069756Z","caller":"traceutil/trace.go:171","msg":"trace[1681416276] transaction","detail":"{read_only:false; response_revision:9197; number_of_response:1; }","duration":"119.907077ms","start":"2026-04-06T21:21:34.949823Z","end":"2026-04-06T21:21:35.06973Z","steps":["trace[1681416276] 'process raft request' (duration: 119.718243ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:21:47.245915Z","caller":"traceutil/trace.go:171","msg":"trace[115746308] transaction","detail":"{read_only:false; response_revision:9268; number_of_response:1; }","duration":"119.17546ms","start":"2026-04-06T21:21:47.126695Z","end":"2026-04-06T21:21:47.24587Z","steps":["trace[115746308] 'process raft request' (duration: 74.62841ms)","trace[115746308] 'compare' (duration: 44.401047ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:21:47.245981Z","caller":"traceutil/trace.go:171","msg":"trace[2127140601] linearizableReadLoop","detail":"{readStateIndex:9596; appliedIndex:9595; }","duration":"104.190798ms","start":"2026-04-06T21:21:47.141749Z","end":"2026-04-06T21:21:47.245939Z","steps":["trace[2127140601] 'read index received' (duration: 59.727329ms)","trace[2127140601] 'applied index is now lower than readState.Index' (duration: 44.459359ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:21:47.246406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.633717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wb5c6\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-06T21:21:47.246508Z","caller":"traceutil/trace.go:171","msg":"trace[1917809047] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wb5c6; range_end:; response_count:1; response_revision:9269; }","duration":"104.768681ms","start":"2026-04-06T21:21:47.141719Z","end":"2026-04-06T21:21:47.246488Z","steps":["trace[1917809047] 'agreement among raft nodes before linearized reading' (duration: 104.310751ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:22:41.449146Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f8844a9a4263041d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-06T21:22:41.455135Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-06T21:22:41.455266Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-06T21:25:03.511741Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8284} {"level":"info","ts":"2026-04-06T21:25:03.594713Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8284,"took":"80.731776ms","hash":4171526829,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":24866816,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-06T21:25:03.594786Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4171526829,"revision":8284,"compact-revision":6110} {"level":"info","ts":"2026-04-06T21:30:03.521337Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10670} {"level":"info","ts":"2026-04-06T21:30:03.607799Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10670,"took":"84.313368ms","hash":4276824677,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":20267008,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-06T21:30:03.607888Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4276824677,"revision":10670,"compact-revision":8284}