{"level":"warn","ts":"2026-06-04T01:42:59.613313Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-04T01:42:59.61341Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129: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.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-06-04T01:42:59.613482Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-04T01:42:59.613495Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-06-04T01:42:59.613526Z","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-06-04T01:42:59.614124Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-06-04T01:42:59.614206Z","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.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-06-04T01:42:59.616153Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.737586ms"} {"level":"info","ts":"2026-06-04T01:42:59.620369Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-06-04T01:42:59.62047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-06-04T01:42:59.620492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-06-04T01:42:59.620511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-04T01:42:59.620525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-06-04T01:42:59.620569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-06-04T01:42:59.625672Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-04T01:42:59.628299Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-04T01:42:59.629318Z","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-06-04T01:42:59.632123Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-04T01:42:59.632356Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-04T01:42:59.632579Z","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-06-04T01:42:59.632703Z","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-06-04T01:42:59.632741Z","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-06-04T01:42:59.633616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-06-04T01:42:59.63416Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-06-04T01:42:59.636654Z","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-06-04T01:42:59.636839Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-06-04T01:42:59.636901Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-06-04T01:42:59.63691Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-04T01:42:59.636966Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-04T01:43:00.121284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-06-04T01:43:00.121359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-06-04T01:43:00.121413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-06-04T01:43:00.121435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-06-04T01:43:00.121447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-06-04T01:43:00.121465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-06-04T01:43:00.12148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-06-04T01:43:00.122341Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T01:43:00.123362Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-04T01:43:00.123353Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-06-04T01:43:00.123421Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-04T01:43:00.12369Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-04T01:43:00.123783Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-04T01:43:00.123788Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T01:43:00.12397Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T01:43:00.124022Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T01:43:00.126926Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-04T01:43:00.127318Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-06-04T01:43:41.717437Z","caller":"traceutil/trace.go:171","msg":"trace[949181014] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"136.042133ms","start":"2026-06-04T01:43:41.581358Z","end":"2026-06-04T01:43:41.7174Z","steps":["trace[949181014] 'process raft request' (duration: 135.398716ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:43:41.942991Z","caller":"traceutil/trace.go:171","msg":"trace[388990172] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"161.465327ms","start":"2026-06-04T01:43:41.781492Z","end":"2026-06-04T01:43:41.942957Z","steps":["trace[388990172] 'process raft request' (duration: 161.289083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:43:42.475162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.830172ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T01:43:42.475437Z","caller":"traceutil/trace.go:171","msg":"trace[2127288607] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"519.714803ms","start":"2026-06-04T01:43:41.955656Z","end":"2026-06-04T01:43:42.47537Z","steps":["trace[2127288607] 'process raft request' (duration: 103.09274ms)","trace[2127288607] 'compare' (duration: 415.686938ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:43:42.475626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:43:41.955624Z","time spent":"519.91298ms","remote":"127.0.0.1:41052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T01:43:42.475443Z","caller":"traceutil/trace.go:171","msg":"trace[1022778599] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"445.495875ms","start":"2026-06-04T01:43:42.029907Z","end":"2026-06-04T01:43:42.475403Z","steps":["trace[1022778599] 'process raft request' (duration: 445.375892ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:43:42.475638Z","caller":"traceutil/trace.go:171","msg":"trace[1649906505] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:612; }","duration":"428.910386ms","start":"2026-06-04T01:43:42.046587Z","end":"2026-06-04T01:43:42.475497Z","steps":["trace[1649906505] 'read index received' (duration: 12.116187ms)","trace[1649906505] 'applied index is now lower than readState.Index' (duration: 416.785299ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:43:42.47583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:43:42.029882Z","time spent":"445.866967ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T01:43:42.475944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.258345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-04T01:43:42.476069Z","caller":"traceutil/trace.go:171","msg":"trace[679635509] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"429.475992ms","start":"2026-06-04T01:43:42.046558Z","end":"2026-06-04T01:43:42.476034Z","steps":["trace[679635509] 'agreement among raft nodes before linearized reading' (duration: 429.05576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:43:42.476145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:43:42.046543Z","time spent":"429.585644ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-04T01:43:42.476158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.584015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-04T01:43:42.476215Z","caller":"traceutil/trace.go:171","msg":"trace[625959058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"398.681848ms","start":"2026-06-04T01:43:42.077516Z","end":"2026-06-04T01:43:42.476198Z","steps":["trace[625959058] 'agreement among raft nodes before linearized reading' (duration: 398.524404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:43:42.476274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:43:42.077499Z","time spent":"398.76495ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-04T01:43:42.476271Z","caller":"traceutil/trace.go:171","msg":"trace[241232597] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"117.328804ms","start":"2026-06-04T01:43:42.358859Z","end":"2026-06-04T01:43:42.476188Z","steps":["trace[241232597] 'process raft request' (duration: 116.730737ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:43:47.916802Z","caller":"traceutil/trace.go:171","msg":"trace[275207235] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:698; }","duration":"120.615005ms","start":"2026-06-04T01:43:47.796163Z","end":"2026-06-04T01:43:47.916778Z","steps":["trace[275207235] 'read index received' (duration: 120.261945ms)","trace[275207235] 'applied index is now lower than readState.Index' (duration: 351.98µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:43:47.916942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.760009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-06-04T01:43:47.916916Z","caller":"traceutil/trace.go:171","msg":"trace[1279077658] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"122.693713ms","start":"2026-06-04T01:43:47.794188Z","end":"2026-06-04T01:43:47.916881Z","steps":["trace[1279077658] 'process raft request' (duration: 122.323703ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:43:47.916984Z","caller":"traceutil/trace.go:171","msg":"trace[2118780480] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:675; }","duration":"120.850301ms","start":"2026-06-04T01:43:47.796123Z","end":"2026-06-04T01:43:47.916973Z","steps":["trace[2118780480] 'agreement among raft nodes before linearized reading' (duration: 120.764359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:43:47.918196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.307949ms","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-06-04T01:43:47.918267Z","caller":"traceutil/trace.go:171","msg":"trace[168460321] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:676; }","duration":"101.397342ms","start":"2026-06-04T01:43:47.816851Z","end":"2026-06-04T01:43:47.918249Z","steps":["trace[168460321] 'agreement among raft nodes before linearized reading' (duration: 101.212357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:45:21.593093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.99423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2e143cf5-0955-4c00-a9af-d1d1e022ab13\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-04T01:45:21.593191Z","caller":"traceutil/trace.go:171","msg":"trace[422904991] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2e143cf5-0955-4c00-a9af-d1d1e022ab13; range_end:; response_count:1; response_revision:1852; }","duration":"234.146714ms","start":"2026-06-04T01:45:21.359025Z","end":"2026-06-04T01:45:21.593171Z","steps":["trace[422904991] 'range keys from in-memory index tree' (duration: 233.801864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:45:21.593187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.055827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2e143cf5-0955-4c00-a9af-d1d1e022ab13\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-04T01:45:21.593273Z","caller":"traceutil/trace.go:171","msg":"trace[701710719] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2e143cf5-0955-4c00-a9af-d1d1e022ab13; range_end:; response_count:1; response_revision:1852; }","duration":"236.204961ms","start":"2026-06-04T01:45:21.357049Z","end":"2026-06-04T01:45:21.593254Z","steps":["trace[701710719] 'range keys from in-memory index tree' (duration: 235.836271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:45:22.057222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.771831ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T01:45:22.057513Z","caller":"traceutil/trace.go:171","msg":"trace[303621716] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"300.209586ms","start":"2026-06-04T01:45:21.757203Z","end":"2026-06-04T01:45:22.057412Z","steps":["trace[303621716] 'process raft request' (duration: 144.164877ms)","trace[303621716] 'compare' (duration: 155.641818ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:45:22.057597Z","caller":"traceutil/trace.go:171","msg":"trace[476301262] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1929; }","duration":"238.611187ms","start":"2026-06-04T01:45:21.818968Z","end":"2026-06-04T01:45:22.05758Z","steps":["trace[476301262] 'read index received' (duration: 82.487637ms)","trace[476301262] 'applied index is now lower than readState.Index' (duration: 156.12258ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:45:22.057691Z","caller":"traceutil/trace.go:171","msg":"trace[432783197] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"299.057954ms","start":"2026-06-04T01:45:21.758623Z","end":"2026-06-04T01:45:22.057681Z","steps":["trace[432783197] 'process raft request' (duration: 298.870959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:45:22.057865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:45:21.757181Z","time spent":"300.482073ms","remote":"127.0.0.1:41036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T01:45:22.057891Z","caller":"traceutil/trace.go:171","msg":"trace[1395108244] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"299.905948ms","start":"2026-06-04T01:45:21.757949Z","end":"2026-06-04T01:45:22.057855Z","steps":["trace[1395108244] 'process raft request' (duration: 299.492826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:45:22.057932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.939757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T01:45:22.057965Z","caller":"traceutil/trace.go:171","msg":"trace[987876444] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"266.528662ms","start":"2026-06-04T01:45:21.791406Z","end":"2026-06-04T01:45:22.057935Z","steps":["trace[987876444] 'process raft request' (duration: 266.127051ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:45:22.057999Z","caller":"traceutil/trace.go:171","msg":"trace[1201525220] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1860; }","duration":"239.028119ms","start":"2026-06-04T01:45:21.818949Z","end":"2026-06-04T01:45:22.057977Z","steps":["trace[1201525220] 'agreement among raft nodes before linearized reading' (duration: 238.899536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:45:22.058055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.273392ms","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-06-04T01:45:22.058012Z","caller":"traceutil/trace.go:171","msg":"trace[1989072404] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"300.621567ms","start":"2026-06-04T01:45:21.757316Z","end":"2026-06-04T01:45:22.057937Z","steps":["trace[1989072404] 'process raft request' (duration: 300.01152ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:45:22.05811Z","caller":"traceutil/trace.go:171","msg":"trace[1492295902] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1860; }","duration":"135.353294ms","start":"2026-06-04T01:45:21.92274Z","end":"2026-06-04T01:45:22.058093Z","steps":["trace[1492295902] 'agreement among raft nodes before linearized reading' (duration: 135.20623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:45:22.058057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:45:21.757931Z","time spent":"300.042511ms","remote":"127.0.0.1:41166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T01:45:22.058272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:45:21.757304Z","time spent":"300.836074ms","remote":"127.0.0.1:41166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T01:45:33.327637Z","caller":"traceutil/trace.go:171","msg":"trace[1628835673] linearizableReadLoop","detail":"{readStateIndex:2033; appliedIndex:2032; }","duration":"186.661338ms","start":"2026-06-04T01:45:33.140942Z","end":"2026-06-04T01:45:33.327603Z","steps":["trace[1628835673] 'read index received' (duration: 186.352339ms)","trace[1628835673] 'applied index is now lower than readState.Index' (duration: 307.129µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:45:33.32788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.917984ms","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-06-04T01:45:33.327968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.842606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-04T01:45:33.327989Z","caller":"traceutil/trace.go:171","msg":"trace[177540782] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1956; }","duration":"187.063298ms","start":"2026-06-04T01:45:33.140895Z","end":"2026-06-04T01:45:33.327958Z","steps":["trace[177540782] 'agreement among raft nodes before linearized reading' (duration: 186.821592ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:45:33.328018Z","caller":"traceutil/trace.go:171","msg":"trace[2121753501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1956; }","duration":"171.953819ms","start":"2026-06-04T01:45:33.15605Z","end":"2026-06-04T01:45:33.328004Z","steps":["trace[2121753501] 'agreement among raft nodes before linearized reading' (duration: 171.741263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:45:33.328168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.374569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-04T01:45:33.328287Z","caller":"traceutil/trace.go:171","msg":"trace[1738316910] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1956; }","duration":"155.545004ms","start":"2026-06-04T01:45:33.172713Z","end":"2026-06-04T01:45:33.328258Z","steps":["trace[1738316910] 'agreement among raft nodes before linearized reading' (duration: 155.143233ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:46:59.892587Z","caller":"traceutil/trace.go:171","msg":"trace[672516049] transaction","detail":"{read_only:false; response_revision:2612; number_of_response:1; }","duration":"252.618146ms","start":"2026-06-04T01:46:59.639937Z","end":"2026-06-04T01:46:59.892555Z","steps":["trace[672516049] 'process raft request' (duration: 252.426051ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:47:00.003232Z","caller":"traceutil/trace.go:171","msg":"trace[1733300341] linearizableReadLoop","detail":"{readStateIndex:2715; appliedIndex:2713; }","duration":"219.78938ms","start":"2026-06-04T01:46:59.783422Z","end":"2026-06-04T01:47:00.003211Z","steps":["trace[1733300341] 'read index received' (duration: 109.014376ms)","trace[1733300341] 'applied index is now lower than readState.Index' (duration: 110.774284ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:47:00.003296Z","caller":"traceutil/trace.go:171","msg":"trace[334696896] transaction","detail":"{read_only:false; response_revision:2613; number_of_response:1; }","duration":"309.845724ms","start":"2026-06-04T01:46:59.693426Z","end":"2026-06-04T01:47:00.003271Z","steps":["trace[334696896] 'process raft request' (duration: 289.156784ms)","trace[334696896] 'compare' (duration: 20.547946ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:47:00.003375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.916984ms","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-06-04T01:47:00.003392Z","caller":"traceutil/trace.go:171","msg":"trace[1377858491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2613; }","duration":"219.946425ms","start":"2026-06-04T01:46:59.783441Z","end":"2026-06-04T01:47:00.003387Z","steps":["trace[1377858491] 'agreement among raft nodes before linearized reading' (duration: 219.860562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:47:00.003397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.974006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-04T01:47:00.00341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:46:59.693398Z","time spent":"309.946877ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T01:47:00.003449Z","caller":"traceutil/trace.go:171","msg":"trace[588472864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2613; }","duration":"220.062578ms","start":"2026-06-04T01:46:59.783372Z","end":"2026-06-04T01:47:00.003434Z","steps":["trace[588472864] 'agreement among raft nodes before linearized reading' (duration: 219.914604ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:47:00.003559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.186592ms","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-06-04T01:47:00.003645Z","caller":"traceutil/trace.go:171","msg":"trace[796758740] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2613; }","duration":"187.312254ms","start":"2026-06-04T01:46:59.816308Z","end":"2026-06-04T01:47:00.003621Z","steps":["trace[796758740] 'agreement among raft nodes before linearized reading' (duration: 187.062097ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:50:09.434153Z","caller":"traceutil/trace.go:171","msg":"trace[1912547754] linearizableReadLoop","detail":"{readStateIndex:3985; appliedIndex:3984; }","duration":"309.11228ms","start":"2026-06-04T01:50:09.125003Z","end":"2026-06-04T01:50:09.434115Z","steps":["trace[1912547754] 'read index received' (duration: 308.978867ms)","trace[1912547754] 'applied index is now lower than readState.Index' (duration: 132.223µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:50:09.434334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.315266ms","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-06-04T01:50:09.434375Z","caller":"traceutil/trace.go:171","msg":"trace[1188978868] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3838; }","duration":"309.410618ms","start":"2026-06-04T01:50:09.124954Z","end":"2026-06-04T01:50:09.434365Z","steps":["trace[1188978868] 'agreement among raft nodes before linearized reading' (duration: 309.286975ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:50:09.434283Z","caller":"traceutil/trace.go:171","msg":"trace[549255600] transaction","detail":"{read_only:false; response_revision:3838; number_of_response:1; }","duration":"309.512641ms","start":"2026-06-04T01:50:09.124727Z","end":"2026-06-04T01:50:09.43424Z","steps":["trace[549255600] 'process raft request' (duration: 309.214453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:50:09.434404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.375083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-04T01:50:09.434448Z","caller":"traceutil/trace.go:171","msg":"trace[954782536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3838; }","duration":"212.471086ms","start":"2026-06-04T01:50:09.221966Z","end":"2026-06-04T01:50:09.434438Z","steps":["trace[954782536] 'agreement among raft nodes before linearized reading' (duration: 212.315652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:50:09.434402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:50:09.124938Z","time spent":"309.456329ms","remote":"127.0.0.1:41356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-04T01:50:09.434837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:50:09.124695Z","time spent":"309.994414ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T01:51:23.259915Z","caller":"traceutil/trace.go:171","msg":"trace[1427729692] linearizableReadLoop","detail":"{readStateIndex:4902; appliedIndex:4901; }","duration":"116.040582ms","start":"2026-06-04T01:51:23.143848Z","end":"2026-06-04T01:51:23.259889Z","steps":["trace[1427729692] 'read index received' (duration: 109.636157ms)","trace[1427729692] 'applied index is now lower than readState.Index' (duration: 6.403235ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:51:23.25997Z","caller":"traceutil/trace.go:171","msg":"trace[1036074437] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"116.484564ms","start":"2026-06-04T01:51:23.143459Z","end":"2026-06-04T01:51:23.259943Z","steps":["trace[1036074437] 'process raft request' (duration: 110.015728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:51:23.260072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.186165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T01:51:23.260138Z","caller":"traceutil/trace.go:171","msg":"trace[2085073864] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:0; response_revision:4718; }","duration":"116.287358ms","start":"2026-06-04T01:51:23.143831Z","end":"2026-06-04T01:51:23.260119Z","steps":["trace[2085073864] 'agreement among raft nodes before linearized reading' (duration: 116.159934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:51:23.260235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.513426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-04T01:51:23.260269Z","caller":"traceutil/trace.go:171","msg":"trace[1909854] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:4718; }","duration":"112.555067ms","start":"2026-06-04T01:51:23.147704Z","end":"2026-06-04T01:51:23.260259Z","steps":["trace[1909854] 'agreement among raft nodes before linearized reading' (duration: 112.489175ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:51:28.531561Z","caller":"traceutil/trace.go:171","msg":"trace[1148042758] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"151.512711ms","start":"2026-06-04T01:51:28.380013Z","end":"2026-06-04T01:51:28.531525Z","steps":["trace[1148042758] 'process raft request' (duration: 113.217584ms)","trace[1148042758] 'compare' (duration: 38.142693ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:51:28.533091Z","caller":"traceutil/trace.go:171","msg":"trace[1163504222] linearizableReadLoop","detail":"{readStateIndex:5069; appliedIndex:5067; }","duration":"142.974118ms","start":"2026-06-04T01:51:28.390095Z","end":"2026-06-04T01:51:28.533069Z","steps":["trace[1163504222] 'read index received' (duration: 103.216701ms)","trace[1163504222] 'applied index is now lower than readState.Index' (duration: 39.756597ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:51:28.533365Z","caller":"traceutil/trace.go:171","msg":"trace[505357926] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"149.069694ms","start":"2026-06-04T01:51:28.384286Z","end":"2026-06-04T01:51:28.533355Z","steps":["trace[505357926] 'process raft request' (duration: 148.668794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:51:28.533553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.015007ms","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-06-04T01:51:28.533607Z","caller":"traceutil/trace.go:171","msg":"trace[450500735] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4879; }","duration":"140.11664ms","start":"2026-06-04T01:51:28.393479Z","end":"2026-06-04T01:51:28.533596Z","steps":["trace[450500735] 'agreement among raft nodes before linearized reading' (duration: 139.919664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:51:28.533731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.585144ms","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-06-04T01:51:28.533824Z","caller":"traceutil/trace.go:171","msg":"trace[888690098] 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:4879; }","duration":"143.754479ms","start":"2026-06-04T01:51:28.390044Z","end":"2026-06-04T01:51:28.533798Z","steps":["trace[888690098] 'agreement among raft nodes before linearized reading' (duration: 143.473281ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:51:33.58243Z","caller":"traceutil/trace.go:171","msg":"trace[919636903] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"135.772161ms","start":"2026-06-04T01:51:33.446631Z","end":"2026-06-04T01:51:33.582404Z","steps":["trace[919636903] 'process raft request' (duration: 135.492274ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:51:33.875232Z","caller":"traceutil/trace.go:171","msg":"trace[1174282015] linearizableReadLoop","detail":"{readStateIndex:5239; appliedIndex:5237; }","duration":"361.306066ms","start":"2026-06-04T01:51:33.513894Z","end":"2026-06-04T01:51:33.8752Z","steps":["trace[1174282015] 'read index received' (duration: 68.277877ms)","trace[1174282015] 'applied index is now lower than readState.Index' (duration: 293.026889ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:51:33.875359Z","caller":"traceutil/trace.go:171","msg":"trace[1664543115] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"427.562035ms","start":"2026-06-04T01:51:33.447763Z","end":"2026-06-04T01:51:33.875325Z","steps":["trace[1664543115] 'process raft request' (duration: 427.194245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:51:33.875444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.522741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-04T01:51:33.875519Z","caller":"traceutil/trace.go:171","msg":"trace[405994176] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:5045; }","duration":"361.649155ms","start":"2026-06-04T01:51:33.513854Z","end":"2026-06-04T01:51:33.875503Z","steps":["trace[405994176] 'agreement among raft nodes before linearized reading' (duration: 361.503841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:51:33.875564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:51:33.513839Z","time spent":"361.715156ms","remote":"127.0.0.1:41362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":9,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-06-04T01:51:33.875682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:51:33.447734Z","time spent":"427.764581ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T01:51:33.889182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.440993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T01:51:33.889237Z","caller":"traceutil/trace.go:171","msg":"trace[950685980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5047; }","duration":"262.526185ms","start":"2026-06-04T01:51:33.626698Z","end":"2026-06-04T01:51:33.889224Z","steps":["trace[950685980] 'agreement among raft nodes before linearized reading' (duration: 262.447753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:51:33.889528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.207454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787096"} {"level":"info","ts":"2026-06-04T01:51:33.889605Z","caller":"traceutil/trace.go:171","msg":"trace[566071016] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5047; }","duration":"278.326647ms","start":"2026-06-04T01:51:33.611258Z","end":"2026-06-04T01:51:33.889584Z","steps":["trace[566071016] 'agreement among raft nodes before linearized reading' (duration: 277.855194ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:51:53.63197Z","caller":"traceutil/trace.go:171","msg":"trace[573493323] linearizableReadLoop","detail":"{readStateIndex:5621; appliedIndex:5620; }","duration":"173.399299ms","start":"2026-06-04T01:51:53.458545Z","end":"2026-06-04T01:51:53.631944Z","steps":["trace[573493323] 'read index received' (duration: 173.153593ms)","trace[573493323] 'applied index is now lower than readState.Index' (duration: 244.546µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:51:53.632109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.533453ms","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-06-04T01:51:53.632073Z","caller":"traceutil/trace.go:171","msg":"trace[826509349] transaction","detail":"{read_only:false; response_revision:5417; number_of_response:1; }","duration":"205.035464ms","start":"2026-06-04T01:51:53.427008Z","end":"2026-06-04T01:51:53.632044Z","steps":["trace[826509349] 'process raft request' (duration: 204.791327ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:51:53.632159Z","caller":"traceutil/trace.go:171","msg":"trace[416996969] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5417; }","duration":"173.630206ms","start":"2026-06-04T01:51:53.458514Z","end":"2026-06-04T01:51:53.632144Z","steps":["trace[416996969] 'agreement among raft nodes before linearized reading' (duration: 173.535253ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:52:44.251563Z","caller":"traceutil/trace.go:171","msg":"trace[1891747329] transaction","detail":"{read_only:false; response_revision:5930; number_of_response:1; }","duration":"118.441262ms","start":"2026-06-04T01:52:44.133102Z","end":"2026-06-04T01:52:44.251543Z","steps":["trace[1891747329] 'process raft request' (duration: 118.311088ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:52:44.269294Z","caller":"traceutil/trace.go:171","msg":"trace[1067234025] transaction","detail":"{read_only:false; response_revision:5931; number_of_response:1; }","duration":"136.166833ms","start":"2026-06-04T01:52:44.133104Z","end":"2026-06-04T01:52:44.269271Z","steps":["trace[1067234025] 'process raft request' (duration: 135.993157ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:53:00.149001Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2963} {"level":"info","ts":"2026-06-04T01:53:00.221941Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2963,"took":"71.455457ms","hash":2093473355,"current-db-size-bytes":58544128,"current-db-size":"58 MB","current-db-size-in-use-bytes":33959936,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-04T01:53:00.221997Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2093473355,"revision":2963,"compact-revision":-1} {"level":"info","ts":"2026-06-04T01:58:00.156543Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6052} {"level":"info","ts":"2026-06-04T01:58:00.252169Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6052,"took":"94.088372ms","hash":4274855195,"current-db-size-bytes":58544128,"current-db-size":"58 MB","current-db-size-in-use-bytes":23420928,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-04T01:58:00.252246Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4274855195,"revision":6052,"compact-revision":2963} {"level":"info","ts":"2026-06-04T01:58:02.671823Z","caller":"traceutil/trace.go:171","msg":"trace[1074043992] transaction","detail":"{read_only:false; response_revision:8285; number_of_response:1; }","duration":"163.223818ms","start":"2026-06-04T01:58:02.508578Z","end":"2026-06-04T01:58:02.671801Z","steps":["trace[1074043992] 'process raft request' (duration: 151.649531ms)","trace[1074043992] 'compare' (duration: 11.29261ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:58:14.091744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.395048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-04T01:58:14.091764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.988074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T01:58:14.091829Z","caller":"traceutil/trace.go:171","msg":"trace[1799951019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8344; }","duration":"130.533202ms","start":"2026-06-04T01:58:13.961278Z","end":"2026-06-04T01:58:14.091811Z","steps":["trace[1799951019] 'range keys from in-memory index tree' (duration: 130.212323ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:58:14.091865Z","caller":"traceutil/trace.go:171","msg":"trace[422504421] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:8344; }","duration":"158.151609ms","start":"2026-06-04T01:58:13.933695Z","end":"2026-06-04T01:58:14.091846Z","steps":["trace[422504421] 'count revisions from in-memory index tree' (duration: 157.887402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:58:14.09204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.123655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-04T01:58:14.092124Z","caller":"traceutil/trace.go:171","msg":"trace[1713214354] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8344; }","duration":"140.230358ms","start":"2026-06-04T01:58:13.951868Z","end":"2026-06-04T01:58:14.092099Z","steps":["trace[1713214354] 'range keys from in-memory index tree' (duration: 139.943779ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:58:14.225363Z","caller":"traceutil/trace.go:171","msg":"trace[854080856] transaction","detail":"{read_only:false; response_revision:8345; number_of_response:1; }","duration":"128.260009ms","start":"2026-06-04T01:58:14.097072Z","end":"2026-06-04T01:58:14.225332Z","steps":["trace[854080856] 'process raft request' (duration: 128.083354ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:58:14.252381Z","caller":"traceutil/trace.go:171","msg":"trace[913582416] transaction","detail":"{read_only:false; response_revision:8346; number_of_response:1; }","duration":"154.723385ms","start":"2026-06-04T01:58:14.097627Z","end":"2026-06-04T01:58:14.25235Z","steps":["trace[913582416] 'process raft request' (duration: 154.578231ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:58:15.766199Z","caller":"traceutil/trace.go:171","msg":"trace[16843624] transaction","detail":"{read_only:false; response_revision:8353; number_of_response:1; }","duration":"123.657233ms","start":"2026-06-04T01:58:15.642492Z","end":"2026-06-04T01:58:15.766149Z","steps":["trace[16843624] 'process raft request' (duration: 90.348489ms)","trace[16843624] 'compare' (duration: 33.183361ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:58:16.007Z","caller":"traceutil/trace.go:171","msg":"trace[1173661003] transaction","detail":"{read_only:false; response_revision:8354; number_of_response:1; }","duration":"125.940356ms","start":"2026-06-04T01:58:15.881026Z","end":"2026-06-04T01:58:16.006966Z","steps":["trace[1173661003] 'process raft request' (duration: 90.839042ms)","trace[1173661003] 'compare' (duration: 34.98331ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:58:16.426522Z","caller":"traceutil/trace.go:171","msg":"trace[1400306862] transaction","detail":"{read_only:false; response_revision:8357; number_of_response:1; }","duration":"123.124939ms","start":"2026-06-04T01:58:16.303327Z","end":"2026-06-04T01:58:16.426452Z","steps":["trace[1400306862] 'process raft request' (duration: 29.219833ms)","trace[1400306862] 'compare' (duration: 93.745002ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:58:43.290956Z","caller":"traceutil/trace.go:171","msg":"trace[1031973584] transaction","detail":"{read_only:false; response_revision:8550; number_of_response:1; }","duration":"319.569629ms","start":"2026-06-04T01:58:42.971364Z","end":"2026-06-04T01:58:43.290933Z","steps":["trace[1031973584] 'process raft request' (duration: 319.433095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:58:43.29113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:58:42.971351Z","time spent":"319.678181ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T01:58:43.403188Z","caller":"traceutil/trace.go:171","msg":"trace[98807023] linearizableReadLoop","detail":"{readStateIndex:8855; appliedIndex:8853; }","duration":"271.090509ms","start":"2026-06-04T01:58:43.132061Z","end":"2026-06-04T01:58:43.403152Z","steps":["trace[98807023] 'read index received' (duration: 158.764977ms)","trace[98807023] 'applied index is now lower than readState.Index' (duration: 112.324192ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:58:43.403373Z","caller":"traceutil/trace.go:171","msg":"trace[1579864004] transaction","detail":"{read_only:false; response_revision:8551; number_of_response:1; }","duration":"431.86426ms","start":"2026-06-04T01:58:42.971489Z","end":"2026-06-04T01:58:43.403353Z","steps":["trace[1579864004] 'process raft request' (duration: 419.845921ms)","trace[1579864004] 'compare' (duration: 11.646219ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:58:43.403514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.04277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-04T01:58:43.403589Z","caller":"traceutil/trace.go:171","msg":"trace[63676619] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:8551; }","duration":"149.165513ms","start":"2026-06-04T01:58:43.254407Z","end":"2026-06-04T01:58:43.403572Z","steps":["trace[63676619] 'agreement among raft nodes before linearized reading' (duration: 148.994538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:58:43.40372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.660514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-04T01:58:43.403778Z","caller":"traceutil/trace.go:171","msg":"trace[1582652976] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:8551; }","duration":"271.713885ms","start":"2026-06-04T01:58:43.132049Z","end":"2026-06-04T01:58:43.403762Z","steps":["trace[1582652976] 'agreement among raft nodes before linearized reading' (duration: 271.53453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:58:43.40353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:58:42.971485Z","time spent":"431.934082ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T01:58:46.554209Z","caller":"traceutil/trace.go:171","msg":"trace[1863531970] transaction","detail":"{read_only:false; response_revision:8571; number_of_response:1; }","duration":"113.381421ms","start":"2026-06-04T01:58:46.44081Z","end":"2026-06-04T01:58:46.554192Z","steps":["trace[1863531970] 'process raft request' (duration: 113.271488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:58:46.813814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.587482ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T01:58:46.813916Z","caller":"traceutil/trace.go:171","msg":"trace[1041321688] linearizableReadLoop","detail":"{readStateIndex:8877; appliedIndex:8876; }","duration":"187.913366ms","start":"2026-06-04T01:58:46.625985Z","end":"2026-06-04T01:58:46.813898Z","steps":["trace[1041321688] 'read index received' (duration: 60.030207ms)","trace[1041321688] 'applied index is now lower than readState.Index' (duration: 127.881589ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:58:46.814005Z","caller":"traceutil/trace.go:171","msg":"trace[176599480] transaction","detail":"{read_only:false; response_revision:8572; number_of_response:1; }","duration":"251.418969ms","start":"2026-06-04T01:58:46.562574Z","end":"2026-06-04T01:58:46.813993Z","steps":["trace[176599480] 'process raft request' (duration: 123.434266ms)","trace[176599480] 'compare' (duration: 127.250952ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:58:46.814244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.260575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T01:58:46.814283Z","caller":"traceutil/trace.go:171","msg":"trace[463735748] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8572; }","duration":"188.334927ms","start":"2026-06-04T01:58:46.625937Z","end":"2026-06-04T01:58:46.814272Z","steps":["trace[463735748] 'agreement among raft nodes before linearized reading' (duration: 188.266985ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:58:55.817967Z","caller":"traceutil/trace.go:171","msg":"trace[76084576] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"132.024533ms","start":"2026-06-04T01:58:55.685908Z","end":"2026-06-04T01:58:55.817933Z","steps":["trace[76084576] 'process raft request' (duration: 96.637711ms)","trace[76084576] 'compare' (duration: 35.152865ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:58:55.984313Z","caller":"traceutil/trace.go:171","msg":"trace[1217363603] transaction","detail":"{read_only:false; response_revision:8662; number_of_response:1; }","duration":"174.460537ms","start":"2026-06-04T01:58:55.809823Z","end":"2026-06-04T01:58:55.984283Z","steps":["trace[1217363603] 'process raft request' (duration: 129.558405ms)","trace[1217363603] 'compare' (duration: 44.656165ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T01:58:55.999158Z","caller":"traceutil/trace.go:171","msg":"trace[1352601795] linearizableReadLoop","detail":"{readStateIndex:8973; appliedIndex:8971; }","duration":"122.715477ms","start":"2026-06-04T01:58:55.876421Z","end":"2026-06-04T01:58:55.999137Z","steps":["trace[1352601795] 'read index received' (duration: 63.100931ms)","trace[1352601795] 'applied index is now lower than readState.Index' (duration: 59.613176ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T01:58:55.999304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.859681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T01:58:55.999345Z","caller":"traceutil/trace.go:171","msg":"trace[689989726] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:8663; }","duration":"122.956384ms","start":"2026-06-04T01:58:55.876377Z","end":"2026-06-04T01:58:55.999333Z","steps":["trace[689989726] 'agreement among raft nodes before linearized reading' (duration: 122.843641ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:58:55.999312Z","caller":"traceutil/trace.go:171","msg":"trace[894692051] transaction","detail":"{read_only:false; response_revision:8663; number_of_response:1; }","duration":"174.652843ms","start":"2026-06-04T01:58:55.824612Z","end":"2026-06-04T01:58:55.999264Z","steps":["trace[894692051] 'process raft request' (duration: 174.359844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:58:57.334902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.741954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"} {"level":"warn","ts":"2026-06-04T01:58:57.334914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.125379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-04T01:58:57.334982Z","caller":"traceutil/trace.go:171","msg":"trace[1659374650] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8667; }","duration":"479.863386ms","start":"2026-06-04T01:58:56.855103Z","end":"2026-06-04T01:58:57.334967Z","steps":["trace[1659374650] 'range keys from in-memory index tree' (duration: 479.61501ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T01:58:57.334994Z","caller":"traceutil/trace.go:171","msg":"trace[729490738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8667; }","duration":"482.264562ms","start":"2026-06-04T01:58:56.852712Z","end":"2026-06-04T01:58:57.334977Z","steps":["trace[729490738] 'range keys from in-memory index tree' (duration: 481.952154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T01:58:57.33501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:58:56.855074Z","time spent":"479.929048ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5168,"request content":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" "} {"level":"warn","ts":"2026-06-04T01:58:57.335045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T01:58:56.852688Z","time spent":"482.338225ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-04T01:59:13.571485Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023de.wal"} {"level":"info","ts":"2026-06-04T02:00:12.029486Z","caller":"traceutil/trace.go:171","msg":"trace[230421432] transaction","detail":"{read_only:false; response_revision:9411; number_of_response:1; }","duration":"117.88437ms","start":"2026-06-04T02:00:11.911576Z","end":"2026-06-04T02:00:12.02946Z","steps":["trace[230421432] 'process raft request' (duration: 117.560681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:20.127218Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102803656506838,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T02:00:20.627481Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102803656506838,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T02:00:21.128526Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102803656506838,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T02:00:21.585817Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.205632096s","expected-duration":"1s"} {"level":"info","ts":"2026-06-04T02:00:21.586538Z","caller":"traceutil/trace.go:171","msg":"trace[647211606] transaction","detail":"{read_only:false; response_revision:9476; number_of_response:1; }","duration":"2.206395777s","start":"2026-06-04T02:00:19.380109Z","end":"2026-06-04T02:00:21.586505Z","steps":["trace[647211606] 'process raft request' (duration: 2.206095549s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.586757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:19.380097Z","time spent":"2.2065082s","remote":"127.0.0.1:40954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T02:00:21.627132Z","caller":"traceutil/trace.go:171","msg":"trace[1179586704] linearizableReadLoop","detail":"{readStateIndex:9811; appliedIndex:9807; }","duration":"2.000828506s","start":"2026-06-04T02:00:19.626226Z","end":"2026-06-04T02:00:21.627054Z","steps":["trace[1179586704] 'read index received' (duration: 1.960446788s)","trace[1179586704] 'applied index is now lower than readState.Index' (duration: 40.380568ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T02:00:21.627259Z","caller":"traceutil/trace.go:171","msg":"trace[363109717] transaction","detail":"{read_only:false; response_revision:9479; number_of_response:1; }","duration":"1.327483478s","start":"2026-06-04T02:00:20.299767Z","end":"2026-06-04T02:00:21.62725Z","steps":["trace[363109717] 'process raft request' (duration: 1.32717888s)"],"step_count":1} {"level":"info","ts":"2026-06-04T02:00:21.627378Z","caller":"traceutil/trace.go:171","msg":"trace[1748423807] transaction","detail":"{read_only:false; response_revision:9480; number_of_response:1; }","duration":"1.114830993s","start":"2026-06-04T02:00:20.512525Z","end":"2026-06-04T02:00:21.627356Z","steps":["trace[1748423807] 'process raft request' (duration: 1.114472433s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.627465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001228156s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T02:00:21.627519Z","caller":"traceutil/trace.go:171","msg":"trace[465313826] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:9480; }","duration":"2.001333129s","start":"2026-06-04T02:00:19.626173Z","end":"2026-06-04T02:00:21.627506Z","steps":["trace[465313826] 'agreement among raft nodes before linearized reading' (duration: 2.001236906s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.627522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470432915s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-04T02:00:21.627516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.935911067s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-04T02:00:21.627552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:19.62615Z","time spent":"2.001392471s","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true "} {"level":"info","ts":"2026-06-04T02:00:21.627573Z","caller":"traceutil/trace.go:171","msg":"trace[1945150924] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:9480; }","duration":"1.470530537s","start":"2026-06-04T02:00:20.157028Z","end":"2026-06-04T02:00:21.627559Z","steps":["trace[1945150924] 'agreement among raft nodes before linearized reading' (duration: 1.470441875s)"],"step_count":1} {"level":"info","ts":"2026-06-04T02:00:21.627601Z","caller":"traceutil/trace.go:171","msg":"trace[1165137680] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:9480; }","duration":"1.93601386s","start":"2026-06-04T02:00:19.691563Z","end":"2026-06-04T02:00:21.627577Z","steps":["trace[1165137680] 'agreement among raft nodes before linearized reading' (duration: 1.935854265s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.627615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:20.512501Z","time spent":"1.114920865s","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T02:00:21.627657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:19.691499Z","time spent":"1.936139803s","remote":"127.0.0.1:41182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":4,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-04T02:00:21.627772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.427996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-04T02:00:21.627834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.673170238s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T02:00:21.627862Z","caller":"traceutil/trace.go:171","msg":"trace[689899302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9480; }","duration":"582.57193ms","start":"2026-06-04T02:00:21.045277Z","end":"2026-06-04T02:00:21.627849Z","steps":["trace[689899302] 'agreement among raft nodes before linearized reading' (duration: 582.363374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.627876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.376249334s","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-06-04T02:00:21.627885Z","caller":"traceutil/trace.go:171","msg":"trace[1735352269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9480; }","duration":"1.673236681s","start":"2026-06-04T02:00:19.954632Z","end":"2026-06-04T02:00:21.627869Z","steps":["trace[1735352269] 'agreement among raft nodes before linearized reading' (duration: 1.673159759s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.627875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.555083393s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kxbj8\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-06-04T02:00:21.627792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.649293545s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-04T02:00:21.627636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:20.157007Z","time spent":"1.470618959s","remote":"127.0.0.1:60722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-04T02:00:21.627956Z","caller":"traceutil/trace.go:171","msg":"trace[1095871225] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kxbj8; range_end:; response_count:1; response_revision:9480; }","duration":"1.555208106s","start":"2026-06-04T02:00:20.07273Z","end":"2026-06-04T02:00:21.627938Z","steps":["trace[1095871225] 'agreement among raft nodes before linearized reading' (duration: 1.554988871s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.627915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:21.045258Z","time spent":"582.648003ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-04T02:00:21.627996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:20.072709Z","time spent":"1.555279959s","remote":"127.0.0.1:41052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-kxbj8\" "} {"level":"warn","ts":"2026-06-04T02:00:21.627994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.677029295s","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-06-04T02:00:21.628027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.08888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-06-04T02:00:21.627882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.645557132s","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-06-04T02:00:21.628045Z","caller":"traceutil/trace.go:171","msg":"trace[500413214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9480; }","duration":"1.677106567s","start":"2026-06-04T02:00:19.95092Z","end":"2026-06-04T02:00:21.628027Z","steps":["trace[500413214] 'agreement among raft nodes before linearized reading' (duration: 1.676946293s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.628047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:20.299745Z","time spent":"1.327575321s","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T02:00:21.628061Z","caller":"traceutil/trace.go:171","msg":"trace[302852667] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9480; }","duration":"577.144712ms","start":"2026-06-04T02:00:21.05091Z","end":"2026-06-04T02:00:21.628054Z","steps":["trace[302852667] 'agreement among raft nodes before linearized reading' (duration: 577.053529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.628089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:19.950904Z","time spent":"1.677177868s","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-04T02:00:21.628083Z","caller":"traceutil/trace.go:171","msg":"trace[1669893465] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9480; }","duration":"1.645767897s","start":"2026-06-04T02:00:19.982301Z","end":"2026-06-04T02:00:21.628069Z","steps":["trace[1669893465] 'agreement among raft nodes before linearized reading' (duration: 1.645529601s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.6281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:21.050898Z","time spent":"577.195013ms","remote":"127.0.0.1:41052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-04T02:00:21.628097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.240175386s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-04T02:00:21.628214Z","caller":"traceutil/trace.go:171","msg":"trace[853853081] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:9480; }","duration":"1.240378902s","start":"2026-06-04T02:00:20.387821Z","end":"2026-06-04T02:00:21.6282Z","steps":["trace[853853081] 'agreement among raft nodes before linearized reading' (duration: 1.239837617s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.628276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:20.387802Z","time spent":"1.240445524s","remote":"127.0.0.1:35950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":63,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-06-04T02:00:21.627954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:19.954624Z","time spent":"1.673318193s","remote":"127.0.0.1:40888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-04T02:00:21.627934Z","caller":"traceutil/trace.go:171","msg":"trace[260727887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9480; }","duration":"1.376344297s","start":"2026-06-04T02:00:20.251567Z","end":"2026-06-04T02:00:21.627911Z","steps":["trace[260727887] 'agreement among raft nodes before linearized reading' (duration: 1.376177412s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.628513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:20.251545Z","time spent":"1.376944312s","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-04T02:00:21.627216Z","caller":"traceutil/trace.go:171","msg":"trace[1583717050] transaction","detail":"{read_only:false; response_revision:9477; number_of_response:1; }","duration":"1.651918047s","start":"2026-06-04T02:00:19.975288Z","end":"2026-06-04T02:00:21.627206Z","steps":["trace[1583717050] 'process raft request' (duration: 1.651434424s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.628705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:19.975272Z","time spent":"1.653374787s","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T02:00:21.627948Z","caller":"traceutil/trace.go:171","msg":"trace[584330835] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9480; }","duration":"1.64948697s","start":"2026-06-04T02:00:19.978453Z","end":"2026-06-04T02:00:21.62794Z","steps":["trace[584330835] 'agreement among raft nodes before linearized reading' (duration: 1.649218002s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.628831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:19.978445Z","time spent":"1.650372184s","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-04T02:00:21.627145Z","caller":"traceutil/trace.go:171","msg":"trace[165774532] transaction","detail":"{read_only:false; response_revision:9478; number_of_response:1; }","duration":"1.576373827s","start":"2026-06-04T02:00:20.050737Z","end":"2026-06-04T02:00:21.627111Z","steps":["trace[165774532] 'process raft request' (duration: 1.576142241s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.628959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:20.050567Z","time spent":"1.578335351s","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T02:00:21.627955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.662905277s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/glance-rabbit-init-lntvl\" ","response":"range_response_count:1 size:6661"} {"level":"info","ts":"2026-06-04T02:00:21.629186Z","caller":"traceutil/trace.go:171","msg":"trace[559650204] range","detail":"{range_begin:/registry/pods/openstack/glance-rabbit-init-lntvl; range_end:; response_count:1; response_revision:9480; }","duration":"1.664146811s","start":"2026-06-04T02:00:19.965021Z","end":"2026-06-04T02:00:21.629168Z","steps":["trace[559650204] 'agreement among raft nodes before linearized reading' (duration: 1.662891776s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:00:21.629226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:19.965008Z","time spent":"1.664207093s","remote":"127.0.0.1:41052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":6683,"request content":"key:\"/registry/pods/openstack/glance-rabbit-init-lntvl\" "} {"level":"warn","ts":"2026-06-04T02:00:21.628129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T02:00:19.982295Z","time spent":"1.645821349s","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-04T02:00:47.712336Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3cec112083e8d3ff","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-04T02:00:47.71772Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-04T02:00:47.717813Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-04T02:03:00.164184Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8272} {"level":"info","ts":"2026-06-04T02:03:00.248966Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8272,"took":"82.616998ms","hash":4094500546,"current-db-size-bytes":58544128,"current-db-size":"58 MB","current-db-size-in-use-bytes":26415104,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-04T02:03:00.249027Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4094500546,"revision":8272,"compact-revision":6052} {"level":"info","ts":"2026-06-04T02:03:52.714498Z","caller":"traceutil/trace.go:171","msg":"trace[256262004] linearizableReadLoop","detail":"{readStateIndex:11621; appliedIndex:11620; }","duration":"115.454502ms","start":"2026-06-04T02:03:52.599017Z","end":"2026-06-04T02:03:52.714472Z","steps":["trace[256262004] 'read index received' (duration: 115.245297ms)","trace[256262004] 'applied index is now lower than readState.Index' (duration: 208.085µs)"],"step_count":2} {"level":"info","ts":"2026-06-04T02:03:52.71457Z","caller":"traceutil/trace.go:171","msg":"trace[1054138745] transaction","detail":"{read_only:false; response_revision:11238; number_of_response:1; }","duration":"118.883308ms","start":"2026-06-04T02:03:52.595641Z","end":"2026-06-04T02:03:52.714525Z","steps":["trace[1054138745] 'process raft request' (duration: 118.671322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:03:52.714749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.697259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-04T02:03:52.714823Z","caller":"traceutil/trace.go:171","msg":"trace[1226516118] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11238; }","duration":"115.804681ms","start":"2026-06-04T02:03:52.599Z","end":"2026-06-04T02:03:52.714805Z","steps":["trace[1226516118] 'agreement among raft nodes before linearized reading' (duration: 115.582295ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T02:08:00.172594Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10752} {"level":"info","ts":"2026-06-04T02:08:00.256078Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10752,"took":"81.118657ms","hash":2624784947,"current-db-size-bytes":58544128,"current-db-size":"58 MB","current-db-size-in-use-bytes":27525120,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-04T02:08:00.256163Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2624784947,"revision":10752,"compact-revision":8272} {"level":"warn","ts":"2026-06-04T02:10:11.993495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.092016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T02:10:11.993573Z","caller":"traceutil/trace.go:171","msg":"trace[1065808505] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:13821; }","duration":"196.22087ms","start":"2026-06-04T02:10:11.797336Z","end":"2026-06-04T02:10:11.993557Z","steps":["trace[1065808505] 'count revisions from in-memory index tree' (duration: 195.941473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T02:10:49.304679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.401078ms","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-06-04T02:10:49.304811Z","caller":"traceutil/trace.go:171","msg":"trace[1398903206] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:14226; }","duration":"130.550953ms","start":"2026-06-04T02:10:49.174237Z","end":"2026-06-04T02:10:49.304788Z","steps":["trace[1398903206] 'count revisions from in-memory index tree' (duration: 130.319846ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T02:13:00.202121Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12863} {"level":"info","ts":"2026-06-04T02:13:00.345576Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12863,"took":"140.799556ms","hash":3874864049,"current-db-size-bytes":58544128,"current-db-size":"58 MB","current-db-size-in-use-bytes":30814208,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-04T02:13:00.345658Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3874864049,"revision":12863,"compact-revision":10752} {"level":"info","ts":"2026-06-04T02:18:00.210172Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15326} {"level":"info","ts":"2026-06-04T02:18:00.303349Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15326,"took":"90.085899ms","hash":3260203091,"current-db-size-bytes":58544128,"current-db-size":"58 MB","current-db-size-in-use-bytes":31612928,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-04T02:18:00.303422Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3260203091,"revision":15326,"compact-revision":12863} {"level":"info","ts":"2026-06-04T02:23:00.215881Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17574} {"level":"info","ts":"2026-06-04T02:23:00.310286Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17574,"took":"90.938424ms","hash":3856710554,"current-db-size-bytes":58544128,"current-db-size":"58 MB","current-db-size-in-use-bytes":26013696,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-04T02:23:00.310349Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3856710554,"revision":17574,"compact-revision":15326} {"level":"info","ts":"2026-06-04T02:23:36.619125Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3cec112083e8d3ff","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-04T02:23:36.623812Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-04T02:23:36.623902Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}