{"level":"warn","ts":"2026-08-13T01:00:22.541092Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T01:00:22.541186Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-08-13T01:00:22.541529Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T01:00:22.541539Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-08-13T01:00:22.541558Z","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-08-13T01:00:22.542313Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-08-13T01:00:22.54265Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-08-13T01:00:22.547509Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.560751ms"} {"level":"info","ts":"2026-08-13T01:00:22.555385Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-08-13T01:00:22.555499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T01:00:22.556962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-08-13T01:00:22.557016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T01:00:22.557058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-08-13T01:00:22.557184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-08-13T01:00:22.567061Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T01:00:22.568827Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T01:00:22.569706Z","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-08-13T01:00:22.574168Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T01:00:22.574346Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T01:00:22.574685Z","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-08-13T01:00:22.574816Z","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-08-13T01:00:22.574826Z","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-08-13T01:00:22.576197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-08-13T01:00:22.577056Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-08-13T01:00:22.578846Z","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-08-13T01:00:22.57891Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-08-13T01:00:22.578939Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-08-13T01:00:22.579925Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T01:00:22.579969Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T01:00:23.257866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T01:00:23.257919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T01:00:23.257954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-08-13T01:00:23.257983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-08-13T01:00:23.258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-08-13T01:00:23.258018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-08-13T01:00:23.258031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-08-13T01:00:23.392075Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T01:00:23.414551Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T01:00:23.414665Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T01:00:23.41465Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T01:00:23.415024Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T01:00:23.415094Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T01:00:23.41836Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T01:00:23.418924Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-08-13T01:00:23.455116Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T01:00:23.455322Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T01:00:23.455382Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T01:00:58.311853Z","caller":"traceutil/trace.go:171","msg":"trace[508576782] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"103.059118ms","start":"2026-08-13T01:00:58.208752Z","end":"2026-08-13T01:00:58.311811Z","steps":["trace[508576782] 'process raft request' (duration: 43.215011ms)","trace[508576782] 'compare' (duration: 59.529979ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:00:58.600116Z","caller":"traceutil/trace.go:171","msg":"trace[559435491] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"264.29424ms","start":"2026-08-13T01:00:58.335788Z","end":"2026-08-13T01:00:58.600083Z","steps":["trace[559435491] 'process raft request' (duration: 264.038174ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:00:58.610331Z","caller":"traceutil/trace.go:171","msg":"trace[1952204194] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"249.231084ms","start":"2026-08-13T01:00:58.361086Z","end":"2026-08-13T01:00:58.610317Z","steps":["trace[1952204194] 'process raft request' (duration: 249.202003ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:00:58.61043Z","caller":"traceutil/trace.go:171","msg":"trace[657715226] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"263.689915ms","start":"2026-08-13T01:00:58.346717Z","end":"2026-08-13T01:00:58.610407Z","steps":["trace[657715226] 'process raft request' (duration: 263.45871ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:01:04.351567Z","caller":"traceutil/trace.go:171","msg":"trace[299361288] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"202.050341ms","start":"2026-08-13T01:01:04.149488Z","end":"2026-08-13T01:01:04.351538Z","steps":["trace[299361288] 'read index received' (duration: 201.282033ms)","trace[299361288] 'applied index is now lower than readState.Index' (duration: 767.218µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:01:04.351738Z","caller":"traceutil/trace.go:171","msg":"trace[2042540285] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"336.136855ms","start":"2026-08-13T01:01:04.015548Z","end":"2026-08-13T01:01:04.351685Z","steps":["trace[2042540285] 'process raft request' (duration: 335.425318ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:01:04.351834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.296878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:01:04.351951Z","caller":"traceutil/trace.go:171","msg":"trace[532595072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"202.493502ms","start":"2026-08-13T01:01:04.149436Z","end":"2026-08-13T01:01:04.35193Z","steps":["trace[532595072] 'agreement among raft nodes before linearized reading' (duration: 202.291338ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:01:04.352391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:01:04.015517Z","time spent":"336.309469ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:01:04.50276Z","caller":"traceutil/trace.go:171","msg":"trace[977760277] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"136.543792ms","start":"2026-08-13T01:01:04.366196Z","end":"2026-08-13T01:01:04.50274Z","steps":["trace[977760277] 'process raft request' (duration: 132.477895ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:01:04.510246Z","caller":"traceutil/trace.go:171","msg":"trace[488892554] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"107.180782ms","start":"2026-08-13T01:01:04.403043Z","end":"2026-08-13T01:01:04.510224Z","steps":["trace[488892554] 'process raft request' (duration: 107.084659ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:01:29.489328Z","caller":"traceutil/trace.go:171","msg":"trace[915224643] linearizableReadLoop","detail":"{readStateIndex:850; appliedIndex:849; }","duration":"203.543084ms","start":"2026-08-13T01:01:29.285757Z","end":"2026-08-13T01:01:29.4893Z","steps":["trace[915224643] 'read index received' (duration: 203.36008ms)","trace[915224643] 'applied index is now lower than readState.Index' (duration: 181.924µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:01:29.489424Z","caller":"traceutil/trace.go:171","msg":"trace[72701292] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"220.402049ms","start":"2026-08-13T01:01:29.268967Z","end":"2026-08-13T01:01:29.489369Z","steps":["trace[72701292] 'process raft request' (duration: 220.212996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:01:29.48953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.765809ms","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-08-13T01:01:29.48957Z","caller":"traceutil/trace.go:171","msg":"trace[748580506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:818; }","duration":"203.872011ms","start":"2026-08-13T01:01:29.285687Z","end":"2026-08-13T01:01:29.489559Z","steps":["trace[748580506] 'agreement among raft nodes before linearized reading' (duration: 203.741859ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:01:29.489702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.529617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fqk28\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-13T01:01:29.489757Z","caller":"traceutil/trace.go:171","msg":"trace[60963433] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fqk28; range_end:; response_count:1; response_revision:818; }","duration":"105.622719ms","start":"2026-08-13T01:01:29.384119Z","end":"2026-08-13T01:01:29.489742Z","steps":["trace[60963433] 'agreement among raft nodes before linearized reading' (duration: 105.496366ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:02:01.805922Z","caller":"traceutil/trace.go:171","msg":"trace[1424348088] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"126.879111ms","start":"2026-08-13T01:02:01.679017Z","end":"2026-08-13T01:02:01.805896Z","steps":["trace[1424348088] 'process raft request' (duration: 126.730919ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:02:01.847898Z","caller":"traceutil/trace.go:171","msg":"trace[802749678] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"168.835979ms","start":"2026-08-13T01:02:01.679028Z","end":"2026-08-13T01:02:01.847864Z","steps":["trace[802749678] 'process raft request' (duration: 166.201055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:02:02.006517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.627088ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-13T01:02:02.00661Z","caller":"traceutil/trace.go:171","msg":"trace[1133569092] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1267; }","duration":"316.496065ms","start":"2026-08-13T01:02:01.690098Z","end":"2026-08-13T01:02:02.006594Z","steps":["trace[1133569092] 'read index received' (duration: 115.711715ms)","trace[1133569092] 'applied index is now lower than readState.Index' (duration: 200.78299ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:02:02.006735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.445993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:02:02.006768Z","caller":"traceutil/trace.go:171","msg":"trace[56597577] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1230; }","duration":"239.518524ms","start":"2026-08-13T01:02:01.767241Z","end":"2026-08-13T01:02:02.006759Z","steps":["trace[56597577] 'agreement among raft nodes before linearized reading' (duration: 239.441773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:02:02.006816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.696608ms","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-08-13T01:02:02.006903Z","caller":"traceutil/trace.go:171","msg":"trace[338365656] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1230; }","duration":"316.801939ms","start":"2026-08-13T01:02:01.690083Z","end":"2026-08-13T01:02:02.006885Z","steps":["trace[338365656] 'agreement among raft nodes before linearized reading' (duration: 316.570036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:02:02.006948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:02:01.690077Z","time spent":"316.863011ms","remote":"127.0.0.1:47944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-13T01:02:50.643968Z","caller":"traceutil/trace.go:171","msg":"trace[371245445] linearizableReadLoop","detail":"{readStateIndex:1992; appliedIndex:1990; }","duration":"267.001583ms","start":"2026-08-13T01:02:50.376918Z","end":"2026-08-13T01:02:50.64392Z","steps":["trace[371245445] 'read index received' (duration: 24.533493ms)","trace[371245445] 'applied index is now lower than readState.Index' (duration: 242.4666ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:02:50.643998Z","caller":"traceutil/trace.go:171","msg":"trace[2123365125] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"283.605415ms","start":"2026-08-13T01:02:50.36036Z","end":"2026-08-13T01:02:50.643965Z","steps":["trace[2123365125] 'process raft request' (duration: 216.813821ms)","trace[2123365125] 'compare' (duration: 66.562281ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:02:50.6442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.264827ms","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-08-13T01:02:50.644252Z","caller":"traceutil/trace.go:171","msg":"trace[2068228298] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1914; }","duration":"267.388109ms","start":"2026-08-13T01:02:50.376855Z","end":"2026-08-13T01:02:50.644243Z","steps":["trace[2068228298] 'agreement among raft nodes before linearized reading' (duration: 267.218716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:02:50.693917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.717777ms","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":"warn","ts":"2026-08-13T01:02:50.693958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.265797ms","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-08-13T01:02:50.694021Z","caller":"traceutil/trace.go:171","msg":"trace[957570375] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1915; }","duration":"237.367799ms","start":"2026-08-13T01:02:50.456639Z","end":"2026-08-13T01:02:50.694007Z","steps":["trace[957570375] 'agreement among raft nodes before linearized reading' (duration: 237.224827ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:02:50.694024Z","caller":"traceutil/trace.go:171","msg":"trace[267186604] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1915; }","duration":"268.831309ms","start":"2026-08-13T01:02:50.425163Z","end":"2026-08-13T01:02:50.693994Z","steps":["trace[267186604] 'agreement among raft nodes before linearized reading' (duration: 268.543025ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:02:50.693928Z","caller":"traceutil/trace.go:171","msg":"trace[1183512452] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"108.776291ms","start":"2026-08-13T01:02:50.58512Z","end":"2026-08-13T01:02:50.693897Z","steps":["trace[1183512452] 'process raft request' (duration: 108.427776ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:02:50.694513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.067094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b479e96f-8a2f-4475-b20b-08c7cf62246c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-13T01:02:50.694563Z","caller":"traceutil/trace.go:171","msg":"trace[1523228837] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b479e96f-8a2f-4475-b20b-08c7cf62246c; range_end:; response_count:1; response_revision:1915; }","duration":"237.133235ms","start":"2026-08-13T01:02:50.457416Z","end":"2026-08-13T01:02:50.69455Z","steps":["trace[1523228837] 'agreement among raft nodes before linearized reading' (duration: 236.401255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:02:51.05105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.446069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T01:02:51.051428Z","caller":"traceutil/trace.go:171","msg":"trace[1823023387] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"354.24111ms","start":"2026-08-13T01:02:50.697164Z","end":"2026-08-13T01:02:51.051405Z","steps":["trace[1823023387] 'process raft request' (duration: 176.328824ms)","trace[1823023387] 'compare' (duration: 177.339888ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:02:51.051553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:02:50.697144Z","time spent":"354.369901ms","remote":"127.0.0.1:47944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:02:51.063039Z","caller":"traceutil/trace.go:171","msg":"trace[1052102814] linearizableReadLoop","detail":"{readStateIndex:1996; appliedIndex:1994; }","duration":"295.070653ms","start":"2026-08-13T01:02:50.767951Z","end":"2026-08-13T01:02:51.063022Z","steps":["trace[1052102814] 'read index received' (duration: 105.543705ms)","trace[1052102814] 'applied index is now lower than readState.Index' (duration: 189.525818ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:02:51.0631Z","caller":"traceutil/trace.go:171","msg":"trace[377783462] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"352.338343ms","start":"2026-08-13T01:02:50.710728Z","end":"2026-08-13T01:02:51.063066Z","steps":["trace[377783462] 'process raft request' (duration: 352.183351ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:02:51.063436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:02:50.710713Z","time spent":"352.457465ms","remote":"127.0.0.1:47944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:02:51.063473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.5208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b479e96f-8a2f-4475-b20b-08c7cf62246c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-13T01:02:51.06351Z","caller":"traceutil/trace.go:171","msg":"trace[1087093851] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b479e96f-8a2f-4475-b20b-08c7cf62246c; range_end:; response_count:1; response_revision:1918; }","duration":"295.59852ms","start":"2026-08-13T01:02:50.7679Z","end":"2026-08-13T01:02:51.063499Z","steps":["trace[1087093851] 'agreement among raft nodes before linearized reading' (duration: 295.213515ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:03:03.448962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.116973ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T01:03:03.449362Z","caller":"traceutil/trace.go:171","msg":"trace[293730833] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"127.445478ms","start":"2026-08-13T01:03:03.32188Z","end":"2026-08-13T01:03:03.449326Z","steps":["trace[293730833] 'process raft request' (duration: 16.881529ms)","trace[293730833] 'compare' (duration: 109.999991ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:03:03.4497Z","caller":"traceutil/trace.go:171","msg":"trace[1461262292] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"122.047065ms","start":"2026-08-13T01:03:03.327635Z","end":"2026-08-13T01:03:03.449682Z","steps":["trace[1461262292] 'process raft request' (duration: 121.884102ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:03:03.449763Z","caller":"traceutil/trace.go:171","msg":"trace[1874363330] transaction","detail":"{read_only:false; response_revision:2024; number_of_response:1; }","duration":"125.859007ms","start":"2026-08-13T01:03:03.323888Z","end":"2026-08-13T01:03:03.449747Z","steps":["trace[1874363330] 'process raft request' (duration: 125.174237ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:03:03.623215Z","caller":"traceutil/trace.go:171","msg":"trace[1094748921] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"163.071201ms","start":"2026-08-13T01:03:03.460121Z","end":"2026-08-13T01:03:03.623192Z","steps":["trace[1094748921] 'process raft request' (duration: 163.025981ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:03:03.623327Z","caller":"traceutil/trace.go:171","msg":"trace[1364384373] transaction","detail":"{read_only:false; response_revision:2028; number_of_response:1; }","duration":"164.902186ms","start":"2026-08-13T01:03:03.458337Z","end":"2026-08-13T01:03:03.623239Z","steps":["trace[1364384373] 'process raft request' (duration: 164.709693ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:03:03.623521Z","caller":"traceutil/trace.go:171","msg":"trace[49026101] transaction","detail":"{read_only:false; response_revision:2027; number_of_response:1; }","duration":"166.881343ms","start":"2026-08-13T01:03:03.45662Z","end":"2026-08-13T01:03:03.623502Z","steps":["trace[49026101] 'process raft request' (duration: 166.278674ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:03:03.623584Z","caller":"traceutil/trace.go:171","msg":"trace[1064679975] transaction","detail":"{read_only:false; response_revision:2029; number_of_response:1; }","duration":"165.158719ms","start":"2026-08-13T01:03:03.458396Z","end":"2026-08-13T01:03:03.623555Z","steps":["trace[1064679975] 'process raft request' (duration: 164.706883ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:03:06.063212Z","caller":"traceutil/trace.go:171","msg":"trace[303654215] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"125.297181ms","start":"2026-08-13T01:03:05.937895Z","end":"2026-08-13T01:03:06.063193Z","steps":["trace[303654215] 'process raft request' (duration: 124.854625ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:03:06.321544Z","caller":"traceutil/trace.go:171","msg":"trace[2104348691] transaction","detail":"{read_only:false; response_revision:2046; number_of_response:1; }","duration":"134.082797ms","start":"2026-08-13T01:03:06.187408Z","end":"2026-08-13T01:03:06.321491Z","steps":["trace[2104348691] 'process raft request' (duration: 133.832374ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:21.350814Z","caller":"traceutil/trace.go:171","msg":"trace[1201852300] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"123.665341ms","start":"2026-08-13T01:04:21.227123Z","end":"2026-08-13T01:04:21.350788Z","steps":["trace[1201852300] 'process raft request' (duration: 123.516874ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:21.350872Z","caller":"traceutil/trace.go:171","msg":"trace[1153534503] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"123.702242ms","start":"2026-08-13T01:04:21.227137Z","end":"2026-08-13T01:04:21.350839Z","steps":["trace[1153534503] 'process raft request' (duration: 123.541405ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:21.350959Z","caller":"traceutil/trace.go:171","msg":"trace[1427859568] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"123.86273ms","start":"2026-08-13T01:04:21.227086Z","end":"2026-08-13T01:04:21.350949Z","steps":["trace[1427859568] 'process raft request' (duration: 123.435641ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:29.753876Z","caller":"traceutil/trace.go:171","msg":"trace[1120620780] linearizableReadLoop","detail":"{readStateIndex:2707; appliedIndex:2706; }","duration":"236.740909ms","start":"2026-08-13T01:04:29.517121Z","end":"2026-08-13T01:04:29.753862Z","steps":["trace[1120620780] 'read index received' (duration: 236.613143ms)","trace[1120620780] 'applied index is now lower than readState.Index' (duration: 127.235µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:04:29.754015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.883765ms","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-08-13T01:04:29.754036Z","caller":"traceutil/trace.go:171","msg":"trace[59829755] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2607; }","duration":"237.00554ms","start":"2026-08-13T01:04:29.517025Z","end":"2026-08-13T01:04:29.75403Z","steps":["trace[59829755] 'agreement among raft nodes before linearized reading' (duration: 236.904595ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:29.75417Z","caller":"traceutil/trace.go:171","msg":"trace[1761312177] transaction","detail":"{read_only:false; response_revision:2607; number_of_response:1; }","duration":"261.640137ms","start":"2026-08-13T01:04:29.492496Z","end":"2026-08-13T01:04:29.754136Z","steps":["trace[1761312177] 'process raft request' (duration: 261.282852ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:34.442594Z","caller":"traceutil/trace.go:171","msg":"trace[272390307] transaction","detail":"{read_only:false; response_revision:2635; number_of_response:1; }","duration":"102.765759ms","start":"2026-08-13T01:04:34.339811Z","end":"2026-08-13T01:04:34.442577Z","steps":["trace[272390307] 'process raft request' (duration: 102.710157ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:34.442599Z","caller":"traceutil/trace.go:171","msg":"trace[1331929295] transaction","detail":"{read_only:false; response_revision:2634; number_of_response:1; }","duration":"102.856274ms","start":"2026-08-13T01:04:34.339725Z","end":"2026-08-13T01:04:34.442581Z","steps":["trace[1331929295] 'process raft request' (duration: 102.77372ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:34.442787Z","caller":"traceutil/trace.go:171","msg":"trace[821129978] transaction","detail":"{read_only:false; response_revision:2633; number_of_response:1; }","duration":"102.963058ms","start":"2026-08-13T01:04:34.33966Z","end":"2026-08-13T01:04:34.442623Z","steps":["trace[821129978] 'process raft request' (duration: 102.077532ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:34.443686Z","caller":"traceutil/trace.go:171","msg":"trace[1625009524] transaction","detail":"{read_only:false; response_revision:2637; number_of_response:1; }","duration":"103.226379ms","start":"2026-08-13T01:04:34.340443Z","end":"2026-08-13T01:04:34.443669Z","steps":["trace[1625009524] 'process raft request' (duration: 103.154346ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:04:34.445236Z","caller":"traceutil/trace.go:171","msg":"trace[201248366] transaction","detail":"{read_only:false; response_revision:2636; number_of_response:1; }","duration":"105.265543ms","start":"2026-08-13T01:04:34.339956Z","end":"2026-08-13T01:04:34.445222Z","steps":["trace[201248366] 'process raft request' (duration: 102.598982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:05:03.362297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.890518ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T01:05:03.362712Z","caller":"traceutil/trace.go:171","msg":"trace[1520410121] transaction","detail":"{read_only:false; response_revision:2790; number_of_response:1; }","duration":"175.32224ms","start":"2026-08-13T01:05:03.187368Z","end":"2026-08-13T01:05:03.36269Z","steps":["trace[1520410121] 'process raft request' (duration: 175.274218ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:05:03.362733Z","caller":"traceutil/trace.go:171","msg":"trace[1665602213] transaction","detail":"{read_only:false; response_revision:2788; number_of_response:1; }","duration":"306.991181ms","start":"2026-08-13T01:05:03.055704Z","end":"2026-08-13T01:05:03.362695Z","steps":["trace[1665602213] 'process raft request' (duration: 184.611576ms)","trace[1665602213] 'compare' (duration: 121.40098ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:05:03.362806Z","caller":"traceutil/trace.go:171","msg":"trace[1502701877] transaction","detail":"{read_only:false; response_revision:2789; number_of_response:1; }","duration":"182.984708ms","start":"2026-08-13T01:05:03.179772Z","end":"2026-08-13T01:05:03.362757Z","steps":["trace[1502701877] 'process raft request' (duration: 182.655956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:05:03.3629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:05:03.055676Z","time spent":"307.134536ms","remote":"127.0.0.1:47944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:08:27.515474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.141458ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T01:08:27.515664Z","caller":"traceutil/trace.go:171","msg":"trace[1911616048] linearizableReadLoop","detail":"{readStateIndex:4226; appliedIndex:4225; }","duration":"189.326379ms","start":"2026-08-13T01:08:27.326306Z","end":"2026-08-13T01:08:27.515633Z","steps":["trace[1911616048] 'read index received' (duration: 33.911806ms)","trace[1911616048] 'applied index is now lower than readState.Index' (duration: 155.412373ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:08:27.515831Z","caller":"traceutil/trace.go:171","msg":"trace[625220939] transaction","detail":"{read_only:false; response_revision:4059; number_of_response:1; }","duration":"202.792704ms","start":"2026-08-13T01:08:27.312995Z","end":"2026-08-13T01:08:27.515788Z","steps":["trace[625220939] 'process raft request' (duration: 47.190437ms)","trace[625220939] 'compare' (duration: 154.920284ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:08:27.515984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.675287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-create-h7r47\" ","response":"range_response_count:1 size:4357"} {"level":"info","ts":"2026-08-13T01:08:27.516035Z","caller":"traceutil/trace.go:171","msg":"trace[749228352] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-create-h7r47; range_end:; response_count:1; response_revision:4059; }","duration":"189.750408ms","start":"2026-08-13T01:08:27.326268Z","end":"2026-08-13T01:08:27.516018Z","steps":["trace[749228352] 'agreement among raft nodes before linearized reading' (duration: 189.536964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:08:27.516015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.824208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T01:08:27.516112Z","caller":"traceutil/trace.go:171","msg":"trace[1860976607] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:4059; }","duration":"138.993401ms","start":"2026-08-13T01:08:27.377099Z","end":"2026-08-13T01:08:27.516092Z","steps":["trace[1860976607] 'agreement among raft nodes before linearized reading' (duration: 138.784477ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:08:42.446203Z","caller":"traceutil/trace.go:171","msg":"trace[84223578] transaction","detail":"{read_only:false; response_revision:4605; number_of_response:1; }","duration":"116.612057ms","start":"2026-08-13T01:08:42.329567Z","end":"2026-08-13T01:08:42.446179Z","steps":["trace[84223578] 'process raft request' (duration: 47.894919ms)","trace[84223578] 'compare' (duration: 68.591375ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:08:44.741395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.45703ms","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-08-13T01:08:44.74146Z","caller":"traceutil/trace.go:171","msg":"trace[1707110046] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4631; }","duration":"136.573072ms","start":"2026-08-13T01:08:44.604871Z","end":"2026-08-13T01:08:44.741444Z","steps":["trace[1707110046] 'range keys from in-memory index tree' (duration: 136.292006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:08:44.741709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.148296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5115e5a5-41cb-4b88-8e77-d096748efe7c\" ","response":"range_response_count:1 size:4067"} {"level":"info","ts":"2026-08-13T01:08:44.74173Z","caller":"traceutil/trace.go:171","msg":"trace[994606226] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5115e5a5-41cb-4b88-8e77-d096748efe7c; range_end:; response_count:1; response_revision:4631; }","duration":"146.207316ms","start":"2026-08-13T01:08:44.595517Z","end":"2026-08-13T01:08:44.741724Z","steps":["trace[994606226] 'range keys from in-memory index tree' (duration: 146.053383ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:09:01.127745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.640598ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T01:09:01.127862Z","caller":"traceutil/trace.go:171","msg":"trace[578240803] linearizableReadLoop","detail":"{readStateIndex:5098; appliedIndex:5097; }","duration":"391.442075ms","start":"2026-08-13T01:09:00.736402Z","end":"2026-08-13T01:09:01.127845Z","steps":["trace[578240803] 'read index received' (duration: 151.530453ms)","trace[578240803] 'applied index is now lower than readState.Index' (duration: 239.910362ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:09:01.128111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.69297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-13T01:09:01.128124Z","caller":"traceutil/trace.go:171","msg":"trace[46438918] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"441.900099ms","start":"2026-08-13T01:09:00.68619Z","end":"2026-08-13T01:09:01.12809Z","steps":["trace[46438918] 'process raft request' (duration: 201.828794ms)","trace[46438918] 'compare' (duration: 239.491754ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:09:01.12819Z","caller":"traceutil/trace.go:171","msg":"trace[250453456] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4910; }","duration":"391.816282ms","start":"2026-08-13T01:09:00.736352Z","end":"2026-08-13T01:09:01.128168Z","steps":["trace[250453456] 'agreement among raft nodes before linearized reading' (duration: 391.589838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:09:01.128244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:09:00.736333Z","time spent":"391.902263ms","remote":"127.0.0.1:47858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-08-13T01:09:01.128277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:09:00.686159Z","time spent":"442.030761ms","remote":"127.0.0.1:47872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13834,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:09:01.128304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.988794ms","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-08-13T01:09:01.128355Z","caller":"traceutil/trace.go:171","msg":"trace[658310066] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4910; }","duration":"278.091925ms","start":"2026-08-13T01:09:00.850249Z","end":"2026-08-13T01:09:01.128341Z","steps":["trace[658310066] 'agreement among raft nodes before linearized reading' (duration: 277.901352ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:09:01.603744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.929959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T01:09:01.60392Z","caller":"traceutil/trace.go:171","msg":"trace[251849606] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"440.142307ms","start":"2026-08-13T01:09:01.163764Z","end":"2026-08-13T01:09:01.603906Z","steps":["trace[251849606] 'process raft request' (duration: 440.067956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:09:01.603999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:09:01.163743Z","time spent":"440.215539ms","remote":"127.0.0.1:47872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10670,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T01:09:01.60414Z","caller":"traceutil/trace.go:171","msg":"trace[1905000507] linearizableReadLoop","detail":"{readStateIndex:5100; appliedIndex:5099; }","duration":"447.434043ms","start":"2026-08-13T01:09:01.156699Z","end":"2026-08-13T01:09:01.604133Z","steps":["trace[1905000507] 'read index received' (duration: 94.117937ms)","trace[1905000507] 'applied index is now lower than readState.Index' (duration: 353.315346ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:09:01.604281Z","caller":"traceutil/trace.go:171","msg":"trace[813036424] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"448.166348ms","start":"2026-08-13T01:09:01.156082Z","end":"2026-08-13T01:09:01.604249Z","steps":["trace[813036424] 'process raft request' (duration: 94.641717ms)","trace[813036424] 'compare' (duration: 352.762166ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:09:01.604375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.390512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-08-13T01:09:01.604402Z","caller":"traceutil/trace.go:171","msg":"trace[490053525] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4913; }","duration":"440.433273ms","start":"2026-08-13T01:09:01.163959Z","end":"2026-08-13T01:09:01.604392Z","steps":["trace[490053525] 'agreement among raft nodes before linearized reading' (duration: 440.351622ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:09:01.604428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:09:01.163951Z","time spent":"440.472764ms","remote":"127.0.0.1:48996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3338,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-08-13T01:09:01.604433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.821891ms","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":"warn","ts":"2026-08-13T01:09:01.604634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.5223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-08-13T01:09:01.604661Z","caller":"traceutil/trace.go:171","msg":"trace[460302856] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4913; }","duration":"158.578311ms","start":"2026-08-13T01:09:01.446077Z","end":"2026-08-13T01:09:01.604655Z","steps":["trace[460302856] 'agreement among raft nodes before linearized reading' (duration: 158.51617ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:09:01.604523Z","caller":"traceutil/trace.go:171","msg":"trace[805730689] 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:4913; }","duration":"447.916932ms","start":"2026-08-13T01:09:01.156585Z","end":"2026-08-13T01:09:01.604502Z","steps":["trace[805730689] 'agreement among raft nodes before linearized reading' (duration: 447.679788ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:09:01.604992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:09:01.156058Z","time spent":"448.29897ms","remote":"127.0.0.1:47944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T01:09:01.605005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:09:01.156576Z","time spent":"448.409631ms","remote":"127.0.0.1:47858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-08-13T01:09:01.802563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.921355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"warn","ts":"2026-08-13T01:09:01.802561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.694556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18cb3811d86812da\" ","response":"range_response_count:1 size:740"} {"level":"info","ts":"2026-08-13T01:09:01.802647Z","caller":"traceutil/trace.go:171","msg":"trace[74127338] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4920; }","duration":"123.035287ms","start":"2026-08-13T01:09:01.67959Z","end":"2026-08-13T01:09:01.802625Z","steps":["trace[74127338] 'agreement among raft nodes before linearized reading' (duration: 77.11067ms)","trace[74127338] 'range keys from in-memory index tree' (duration: 45.668863ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:09:01.802749Z","caller":"traceutil/trace.go:171","msg":"trace[412917788] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18cb3811d86812da; range_end:; response_count:1; response_revision:4920; }","duration":"111.910939ms","start":"2026-08-13T01:09:01.690806Z","end":"2026-08-13T01:09:01.802717Z","steps":["trace[412917788] 'agreement among raft nodes before linearized reading' (duration: 111.606343ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:09:01.915675Z","caller":"traceutil/trace.go:171","msg":"trace[61137765] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"151.924886ms","start":"2026-08-13T01:09:01.763703Z","end":"2026-08-13T01:09:01.915628Z","steps":["trace[61137765] 'process raft request' (duration: 92.853593ms)","trace[61137765] 'compare' (duration: 58.447771ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:09:01.915869Z","caller":"traceutil/trace.go:171","msg":"trace[2127933095] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"152.023589ms","start":"2026-08-13T01:09:01.763798Z","end":"2026-08-13T01:09:01.915822Z","steps":["trace[2127933095] 'process raft request' (duration: 151.615161ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:09:01.916436Z","caller":"traceutil/trace.go:171","msg":"trace[1054815102] transaction","detail":"{read_only:false; response_revision:4924; number_of_response:1; }","duration":"152.598979ms","start":"2026-08-13T01:09:01.763818Z","end":"2026-08-13T01:09:01.916417Z","steps":["trace[1054815102] 'process raft request' (duration: 151.730732ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:09:01.917015Z","caller":"traceutil/trace.go:171","msg":"trace[346837119] transaction","detail":"{read_only:false; response_revision:4925; number_of_response:1; }","duration":"145.055839ms","start":"2026-08-13T01:09:01.771946Z","end":"2026-08-13T01:09:01.917001Z","steps":["trace[346837119] 'process raft request' (duration: 144.407476ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:09:01.917859Z","caller":"traceutil/trace.go:171","msg":"trace[223433400] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"112.125724ms","start":"2026-08-13T01:09:01.805688Z","end":"2026-08-13T01:09:01.917814Z","steps":["trace[223433400] 'process raft request' (duration: 111.262028ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:09:01.917276Z","caller":"traceutil/trace.go:171","msg":"trace[1531524164] linearizableReadLoop","detail":"{readStateIndex:5115; appliedIndex:5110; }","duration":"110.545394ms","start":"2026-08-13T01:09:01.806714Z","end":"2026-08-13T01:09:01.91726Z","steps":["trace[1531524164] 'read index received' (duration: 12.984103ms)","trace[1531524164] 'applied index is now lower than readState.Index' (duration: 97.560421ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T01:09:01.918144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.42318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-001794e1-178e-4a94-a5cc-1a67492b9d31\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-08-13T01:09:01.918226Z","caller":"traceutil/trace.go:171","msg":"trace[1780393620] range","detail":"{range_begin:/registry/persistentvolumes/pvc-001794e1-178e-4a94-a5cc-1a67492b9d31; range_end:; response_count:1; response_revision:4926; }","duration":"111.546823ms","start":"2026-08-13T01:09:01.806665Z","end":"2026-08-13T01:09:01.918212Z","steps":["trace[1780393620] 'agreement among raft nodes before linearized reading' (duration: 111.217767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T01:09:01.91825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.518262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-13T01:09:01.91929Z","caller":"traceutil/trace.go:171","msg":"trace[1949299271] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4926; }","duration":"112.601873ms","start":"2026-08-13T01:09:01.806669Z","end":"2026-08-13T01:09:01.919271Z","steps":["trace[1949299271] 'agreement among raft nodes before linearized reading' (duration: 111.426481ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T01:10:23.440659Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2896} {"level":"info","ts":"2026-08-13T01:10:23.523816Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2896,"took":"81.866803ms","hash":1488068966,"current-db-size-bytes":53510144,"current-db-size":"54 MB","current-db-size-in-use-bytes":29364224,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-13T01:10:23.523883Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1488068966,"revision":2896,"compact-revision":-1} {"level":"info","ts":"2026-08-13T01:15:23.44531Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5575} {"level":"info","ts":"2026-08-13T01:15:23.532592Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5575,"took":"85.340432ms","hash":1515405803,"current-db-size-bytes":53510144,"current-db-size":"54 MB","current-db-size-in-use-bytes":18223104,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-13T01:15:23.532682Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1515405803,"revision":5575,"compact-revision":2896}