{"level":"warn","ts":"2026-06-08T01:06:14.984394Z","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-08T01:06:14.984507Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216: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-08T01:06:14.98473Z","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-08T01:06:14.984778Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-06-08T01:06:14.984853Z","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-08T01:06:14.985976Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-06-08T01:06:14.986058Z","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.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216: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-08T01:06:14.992087Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.77044ms"} {"level":"info","ts":"2026-06-08T01:06:14.998863Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-06-08T01:06:14.998919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-06-08T01:06:14.998941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-06-08T01:06:14.998962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-08T01:06:14.998971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-06-08T01:06:14.999014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-06-08T01:06:15.008956Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-08T01:06:15.011244Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-08T01:06:15.012901Z","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-08T01:06:15.015246Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-08T01:06:15.015782Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-08T01:06:15.016043Z","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-08T01:06:15.016109Z","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-08T01:06:15.01613Z","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-08T01:06:15.016543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-06-08T01:06:15.016761Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-06-08T01:06:15.017902Z","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-08T01:06:15.018153Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-08T01:06:15.018185Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-08T01:06:15.01801Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-06-08T01:06:15.019478Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-06-08T01:06:15.69959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-06-08T01:06:15.699681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-06-08T01:06:15.699714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-06-08T01:06:15.699732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-06-08T01:06:15.699743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-06-08T01:06:15.699768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-06-08T01:06:15.699785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-06-08T01:06:15.700911Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T01:06:15.701801Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-06-08T01:06:15.702015Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T01:06:15.702044Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T01:06:15.702476Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T01:06:15.702597Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T01:06:15.70263Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T01:06:15.70485Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-08T01:06:15.705538Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"info","ts":"2026-06-08T01:06:15.705647Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-08T01:06:15.705701Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-08T01:06:33.63991Z","caller":"traceutil/trace.go:171","msg":"trace[1193667983] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"122.6777ms","start":"2026-06-08T01:06:33.517201Z","end":"2026-06-08T01:06:33.639879Z","steps":["trace[1193667983] 'process raft request' (duration: 94.311129ms)","trace[1193667983] 'compare' (duration: 28.239049ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:06:33.997114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.88929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T01:06:33.997217Z","caller":"traceutil/trace.go:171","msg":"trace[474297832] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:375; }","duration":"127.163815ms","start":"2026-06-08T01:06:33.870033Z","end":"2026-06-08T01:06:33.997197Z","steps":["trace[474297832] 'range keys from in-memory index tree' (duration: 126.760767ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:07:02.903676Z","caller":"traceutil/trace.go:171","msg":"trace[1897650803] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"369.837163ms","start":"2026-06-08T01:07:02.533781Z","end":"2026-06-08T01:07:02.903618Z","steps":["trace[1897650803] 'process raft request' (duration: 337.808902ms)","trace[1897650803] 'compare' (duration: 31.793917ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:07:02.90434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:07:02.533731Z","time spent":"370.043907ms","remote":"127.0.0.1:50328","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-08T01:07:03.388228Z","caller":"traceutil/trace.go:171","msg":"trace[241910340] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"349.842682ms","start":"2026-06-08T01:07:03.038348Z","end":"2026-06-08T01:07:03.388191Z","steps":["trace[241910340] 'read index received' (duration: 336.246083ms)","trace[241910340] 'applied index is now lower than readState.Index' (duration: 13.595379ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:07:03.388306Z","caller":"traceutil/trace.go:171","msg":"trace[1680833512] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"443.140682ms","start":"2026-06-08T01:07:02.945132Z","end":"2026-06-08T01:07:03.388273Z","steps":["trace[1680833512] 'process raft request' (duration: 429.645464ms)","trace[1680833512] 'compare' (duration: 12.995989ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:07:03.388444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:07:02.945098Z","time spent":"443.260874ms","remote":"127.0.0.1:50254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T01:07:03.388443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.654949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-08T01:07:03.38851Z","caller":"traceutil/trace.go:171","msg":"trace[518097115] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:598; }","duration":"187.772851ms","start":"2026-06-08T01:07:03.200721Z","end":"2026-06-08T01:07:03.388494Z","steps":["trace[518097115] 'agreement among raft nodes before linearized reading' (duration: 187.670859ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:07:03.388443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.089537ms","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-08T01:07:03.388787Z","caller":"traceutil/trace.go:171","msg":"trace[1858834836] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:598; }","duration":"350.468554ms","start":"2026-06-08T01:07:03.038296Z","end":"2026-06-08T01:07:03.388764Z","steps":["trace[1858834836] 'agreement among raft nodes before linearized reading' (duration: 350.057927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:07:03.388855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:07:03.038273Z","time spent":"350.562926ms","remote":"127.0.0.1:50394","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-08T01:07:17.9826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.136688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T01:07:17.982704Z","caller":"traceutil/trace.go:171","msg":"trace[2112958542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"113.295211ms","start":"2026-06-08T01:07:17.869386Z","end":"2026-06-08T01:07:17.982681Z","steps":["trace[2112958542] 'range keys from in-memory index tree' (duration: 112.992776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:07:17.982843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.492432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T01:07:17.982979Z","caller":"traceutil/trace.go:171","msg":"trace[106036656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:756; }","duration":"137.716976ms","start":"2026-06-08T01:07:17.845227Z","end":"2026-06-08T01:07:17.982944Z","steps":["trace[106036656] 'range keys from in-memory index tree' (duration: 137.180766ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:08:36.332437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.796047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T01:08:36.332652Z","caller":"traceutil/trace.go:171","msg":"trace[762507345] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1914; }","duration":"365.00641ms","start":"2026-06-08T01:08:35.967629Z","end":"2026-06-08T01:08:36.332636Z","steps":["trace[762507345] 'read index received' (duration: 49.256155ms)","trace[762507345] 'applied index is now lower than readState.Index' (duration: 315.749175ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:08:36.33288Z","caller":"traceutil/trace.go:171","msg":"trace[228039571] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"394.134783ms","start":"2026-06-08T01:08:35.938694Z","end":"2026-06-08T01:08:36.332829Z","steps":["trace[228039571] 'process raft request' (duration: 78.080852ms)","trace[228039571] 'compare' (duration: 314.701106ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:08:36.333023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.339226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b5afb4d-c062-44d7-88cd-23fecdbc5310\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-06-08T01:08:36.33309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.531658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-06-08T01:08:36.333159Z","caller":"traceutil/trace.go:171","msg":"trace[958515255] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4b5afb4d-c062-44d7-88cd-23fecdbc5310; range_end:; response_count:1; response_revision:1841; }","duration":"365.52798ms","start":"2026-06-08T01:08:35.967586Z","end":"2026-06-08T01:08:36.333114Z","steps":["trace[958515255] 'agreement among raft nodes before linearized reading' (duration: 365.223704ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:08:36.333164Z","caller":"traceutil/trace.go:171","msg":"trace[205126146] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1841; }","duration":"357.64879ms","start":"2026-06-08T01:08:35.975504Z","end":"2026-06-08T01:08:36.333153Z","steps":["trace[205126146] 'agreement among raft nodes before linearized reading' (duration: 357.422396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:08:36.333245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:08:35.967572Z","time spent":"365.631752ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b5afb4d-c062-44d7-88cd-23fecdbc5310\" "} {"level":"warn","ts":"2026-06-08T01:08:36.333238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:08:35.975495Z","time spent":"357.732751ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10690,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"warn","ts":"2026-06-08T01:08:36.333359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.422915ms","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-08T01:08:36.333401Z","caller":"traceutil/trace.go:171","msg":"trace[1514042595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1841; }","duration":"190.483866ms","start":"2026-06-08T01:08:36.142908Z","end":"2026-06-08T01:08:36.333391Z","steps":["trace[1514042595] 'agreement among raft nodes before linearized reading' (duration: 190.271112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:08:36.33349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:08:35.938665Z","time spent":"394.595432ms","remote":"127.0.0.1:50394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T01:08:36.455727Z","caller":"traceutil/trace.go:171","msg":"trace[1696662416] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"110.834163ms","start":"2026-06-08T01:08:36.34479Z","end":"2026-06-08T01:08:36.455625Z","steps":["trace[1696662416] 'process raft request' (duration: 110.64417ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:08:36.67426Z","caller":"traceutil/trace.go:171","msg":"trace[606312072] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"124.798809ms","start":"2026-06-08T01:08:36.549428Z","end":"2026-06-08T01:08:36.674227Z","steps":["trace[606312072] 'process raft request' (duration: 72.010397ms)","trace[606312072] 'compare' (duration: 52.65019ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:08:44.131189Z","caller":"traceutil/trace.go:171","msg":"trace[1776254054] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"116.671406ms","start":"2026-06-08T01:08:44.014485Z","end":"2026-06-08T01:08:44.131156Z","steps":["trace[1776254054] 'process raft request' (duration: 101.428167ms)","trace[1776254054] 'compare' (duration: 15.104616ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:09:26.745834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.892645ms","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-08T01:09:26.74593Z","caller":"traceutil/trace.go:171","msg":"trace[710597724] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2169; }","duration":"101.031218ms","start":"2026-06-08T01:09:26.644879Z","end":"2026-06-08T01:09:26.74591Z","steps":["trace[710597724] 'range keys from in-memory index tree' (duration: 100.711132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:09:27.052035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.033306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T01:09:27.052012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.024464ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T01:09:27.052132Z","caller":"traceutil/trace.go:171","msg":"trace[441218767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2171; }","duration":"182.164819ms","start":"2026-06-08T01:09:26.869938Z","end":"2026-06-08T01:09:27.052103Z","steps":["trace[441218767] 'range keys from in-memory index tree' (duration: 181.958715ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:09:27.052171Z","caller":"traceutil/trace.go:171","msg":"trace[1279063202] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2171; }","duration":"125.191658ms","start":"2026-06-08T01:09:26.926946Z","end":"2026-06-08T01:09:27.052138Z","steps":["trace[1279063202] 'range keys from in-memory index tree' (duration: 125.001372ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:10:18.547822Z","caller":"traceutil/trace.go:171","msg":"trace[765824665] transaction","detail":"{read_only:false; response_revision:2621; number_of_response:1; }","duration":"189.231855ms","start":"2026-06-08T01:10:18.358569Z","end":"2026-06-08T01:10:18.5478Z","steps":["trace[765824665] 'process raft request' (duration: 189.109393ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:10:52.382639Z","caller":"traceutil/trace.go:171","msg":"trace[652025094] transaction","detail":"{read_only:false; response_revision:2826; number_of_response:1; }","duration":"144.271169ms","start":"2026-06-08T01:10:52.238337Z","end":"2026-06-08T01:10:52.382608Z","steps":["trace[652025094] 'process raft request' (duration: 96.36121ms)","trace[652025094] 'compare' (duration: 47.801357ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:13:28.512059Z","caller":"traceutil/trace.go:171","msg":"trace[1594867417] transaction","detail":"{read_only:false; response_revision:3851; number_of_response:1; }","duration":"235.911041ms","start":"2026-06-08T01:13:28.276034Z","end":"2026-06-08T01:13:28.511945Z","steps":["trace[1594867417] 'process raft request' (duration: 235.653566ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:14:49.007326Z","caller":"traceutil/trace.go:171","msg":"trace[1592639099] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"126.83902ms","start":"2026-06-08T01:14:48.880429Z","end":"2026-06-08T01:14:49.007268Z","steps":["trace[1592639099] 'process raft request' (duration: 126.590755ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:14:49.147999Z","caller":"traceutil/trace.go:171","msg":"trace[1456237066] linearizableReadLoop","detail":"{readStateIndex:5009; appliedIndex:5007; }","duration":"206.002949ms","start":"2026-06-08T01:14:48.941967Z","end":"2026-06-08T01:14:49.14797Z","steps":["trace[1456237066] 'read index received' (duration: 65.222255ms)","trace[1456237066] 'applied index is now lower than readState.Index' (duration: 140.778894ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:14:49.148312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.319465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-08T01:14:49.148382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.224232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"warn","ts":"2026-06-08T01:14:49.148429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.615991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:9 size:71538"} {"level":"info","ts":"2026-06-08T01:14:49.148478Z","caller":"traceutil/trace.go:171","msg":"trace[1802124917] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"216.221123ms","start":"2026-06-08T01:14:48.93224Z","end":"2026-06-08T01:14:49.148461Z","steps":["trace[1802124917] 'process raft request' (duration: 215.540311ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:14:49.148489Z","caller":"traceutil/trace.go:171","msg":"trace[358981018] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:9; response_revision:4821; }","duration":"130.743834ms","start":"2026-06-08T01:14:49.017731Z","end":"2026-06-08T01:14:49.148475Z","steps":["trace[358981018] 'agreement among raft nodes before linearized reading' (duration: 130.427338ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:14:49.148419Z","caller":"traceutil/trace.go:171","msg":"trace[250045043] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4821; }","duration":"206.495208ms","start":"2026-06-08T01:14:48.941902Z","end":"2026-06-08T01:14:49.148398Z","steps":["trace[250045043] 'agreement among raft nodes before linearized reading' (duration: 206.144942ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:14:49.148487Z","caller":"traceutil/trace.go:171","msg":"trace[1738943488] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4821; }","duration":"131.411576ms","start":"2026-06-08T01:14:49.017053Z","end":"2026-06-08T01:14:49.148464Z","steps":["trace[1738943488] 'agreement among raft nodes before linearized reading' (duration: 131.129431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:14:49.148345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.70206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de793db3-256d-41c2-b115-de9468d084a0\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-06-08T01:14:49.148853Z","caller":"traceutil/trace.go:171","msg":"trace[845761298] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-de793db3-256d-41c2-b115-de9468d084a0; range_end:; response_count:1; response_revision:4821; }","duration":"187.289001ms","start":"2026-06-08T01:14:48.961547Z","end":"2026-06-08T01:14:49.148836Z","steps":["trace[845761298] 'agreement among raft nodes before linearized reading' (duration: 186.588648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:14:54.939975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.221023ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T01:14:54.940258Z","caller":"traceutil/trace.go:171","msg":"trace[904830959] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"123.850749ms","start":"2026-06-08T01:14:54.816389Z","end":"2026-06-08T01:14:54.94024Z","steps":["trace[904830959] 'process raft request' (duration: 123.719527ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:14:54.940446Z","caller":"traceutil/trace.go:171","msg":"trace[432488097] linearizableReadLoop","detail":"{readStateIndex:5209; appliedIndex:5208; }","duration":"247.067905ms","start":"2026-06-08T01:14:54.693336Z","end":"2026-06-08T01:14:54.940404Z","steps":["trace[432488097] 'read index received' (duration: 57.23546ms)","trace[432488097] 'applied index is now lower than readState.Index' (duration: 189.829485ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:14:54.940649Z","caller":"traceutil/trace.go:171","msg":"trace[263905035] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"350.475668ms","start":"2026-06-08T01:14:54.590154Z","end":"2026-06-08T01:14:54.940629Z","steps":["trace[263905035] 'process raft request' (duration: 160.502309ms)","trace[263905035] 'compare' (duration: 188.969899ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:14:54.94082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:14:54.590117Z","time spent":"350.58493ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5837,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T01:14:54.940875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.279386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:413130"} {"level":"info","ts":"2026-06-08T01:14:54.940917Z","caller":"traceutil/trace.go:171","msg":"trace[1449839206] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:5016; }","duration":"231.350667ms","start":"2026-06-08T01:14:54.709553Z","end":"2026-06-08T01:14:54.940904Z","steps":["trace[1449839206] 'agreement among raft nodes before linearized reading' (duration: 231.106932ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:14:54.941426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.617275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-06-08T01:14:54.941501Z","caller":"traceutil/trace.go:171","msg":"trace[1224667535] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5016; }","duration":"175.716107ms","start":"2026-06-08T01:14:54.765765Z","end":"2026-06-08T01:14:54.941481Z","steps":["trace[1224667535] 'agreement among raft nodes before linearized reading' (duration: 175.509924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:14:54.941668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.339241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:782387"} {"level":"info","ts":"2026-06-08T01:14:54.941712Z","caller":"traceutil/trace.go:171","msg":"trace[1567330215] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5016; }","duration":"248.427491ms","start":"2026-06-08T01:14:54.693275Z","end":"2026-06-08T01:14:54.941703Z","steps":["trace[1567330215] 'agreement among raft nodes before linearized reading' (duration: 247.939462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:14:54.942049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.760101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-08T01:14:54.942077Z","caller":"traceutil/trace.go:171","msg":"trace[390457384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5016; }","duration":"213.834792ms","start":"2026-06-08T01:14:54.728236Z","end":"2026-06-08T01:14:54.942071Z","steps":["trace[390457384] 'agreement among raft nodes before linearized reading' (duration: 213.759931ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:14:57.225113Z","caller":"traceutil/trace.go:171","msg":"trace[565723972] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"129.554518ms","start":"2026-06-08T01:14:57.095521Z","end":"2026-06-08T01:14:57.225076Z","steps":["trace[565723972] 'process raft request' (duration: 98.540727ms)","trace[565723972] 'compare' (duration: 30.785427ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:15:17.352006Z","caller":"traceutil/trace.go:171","msg":"trace[1302813427] transaction","detail":"{read_only:false; response_revision:5443; number_of_response:1; }","duration":"134.982691ms","start":"2026-06-08T01:15:17.216979Z","end":"2026-06-08T01:15:17.351962Z","steps":["trace[1302813427] 'process raft request' (duration: 42.932748ms)","trace[1302813427] 'compare' (duration: 91.775168ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:15:17.352033Z","caller":"traceutil/trace.go:171","msg":"trace[1586909559] transaction","detail":"{read_only:false; response_revision:5444; number_of_response:1; }","duration":"133.911131ms","start":"2026-06-08T01:15:17.218089Z","end":"2026-06-08T01:15:17.352Z","steps":["trace[1586909559] 'process raft request' (duration: 133.780218ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:15:17.352466Z","caller":"traceutil/trace.go:171","msg":"trace[467845242] transaction","detail":"{read_only:false; response_revision:5445; number_of_response:1; }","duration":"127.132941ms","start":"2026-06-08T01:15:17.225302Z","end":"2026-06-08T01:15:17.352435Z","steps":["trace[467845242] 'process raft request' (duration: 126.637151ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:15:29.417001Z","caller":"traceutil/trace.go:171","msg":"trace[220482815] transaction","detail":"{read_only:false; response_revision:5620; number_of_response:1; }","duration":"138.802724ms","start":"2026-06-08T01:15:29.278163Z","end":"2026-06-08T01:15:29.416966Z","steps":["trace[220482815] 'process raft request' (duration: 138.619311ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:15:29.459526Z","caller":"traceutil/trace.go:171","msg":"trace[762324090] transaction","detail":"{read_only:false; response_revision:5621; number_of_response:1; }","duration":"177.341119ms","start":"2026-06-08T01:15:29.282159Z","end":"2026-06-08T01:15:29.459501Z","steps":["trace[762324090] 'process raft request' (duration: 177.152435ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:15:29.459749Z","caller":"traceutil/trace.go:171","msg":"trace[874392035] linearizableReadLoop","detail":"{readStateIndex:5833; appliedIndex:5831; }","duration":"160.704561ms","start":"2026-06-08T01:15:29.298759Z","end":"2026-06-08T01:15:29.459464Z","steps":["trace[874392035] 'read index received' (duration: 117.985617ms)","trace[874392035] 'applied index is now lower than readState.Index' (duration: 42.717934ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:15:29.46008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.279153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-08T01:15:29.46022Z","caller":"traceutil/trace.go:171","msg":"trace[551546229] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5621; }","duration":"161.486086ms","start":"2026-06-08T01:15:29.298707Z","end":"2026-06-08T01:15:29.460193Z","steps":["trace[551546229] 'agreement among raft nodes before linearized reading' (duration: 161.055358ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:16:15.73001Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2958} {"level":"info","ts":"2026-06-08T01:16:15.800477Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2958,"took":"68.332721ms","hash":3042963781,"current-db-size-bytes":56483840,"current-db-size":"56 MB","current-db-size-in-use-bytes":33873920,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-08T01:16:15.800542Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3042963781,"revision":2958,"compact-revision":-1} {"level":"info","ts":"2026-06-08T01:21:15.736778Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6031} {"level":"info","ts":"2026-06-08T01:21:15.834159Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6031,"took":"95.363496ms","hash":3017047598,"current-db-size-bytes":56483840,"current-db-size":"56 MB","current-db-size-in-use-bytes":21901312,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-08T01:21:15.834267Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3017047598,"revision":6031,"compact-revision":2958} {"level":"info","ts":"2026-06-08T01:21:30.210377Z","caller":"traceutil/trace.go:171","msg":"trace[1943286938] transaction","detail":"{read_only:false; response_revision:8332; number_of_response:1; }","duration":"205.493489ms","start":"2026-06-08T01:21:30.004845Z","end":"2026-06-08T01:21:30.210339Z","steps":["trace[1943286938] 'process raft request' (duration: 205.269545ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:21:30.344202Z","caller":"traceutil/trace.go:171","msg":"trace[2034353868] transaction","detail":"{read_only:false; response_revision:8333; number_of_response:1; }","duration":"130.422359ms","start":"2026-06-08T01:21:30.213746Z","end":"2026-06-08T01:21:30.344169Z","steps":["trace[2034353868] 'process raft request' (duration: 129.183756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:21:41.83994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.721956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T01:21:41.840014Z","caller":"traceutil/trace.go:171","msg":"trace[1014044160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8393; }","duration":"160.856949ms","start":"2026-06-08T01:21:41.679142Z","end":"2026-06-08T01:21:41.839999Z","steps":["trace[1014044160] 'range keys from in-memory index tree' (duration: 160.570003ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:21:42.808193Z","caller":"traceutil/trace.go:171","msg":"trace[355837683] transaction","detail":"{read_only:false; response_revision:8397; number_of_response:1; }","duration":"259.859412ms","start":"2026-06-08T01:21:42.548307Z","end":"2026-06-08T01:21:42.808167Z","steps":["trace[355837683] 'process raft request' (duration: 235.514959ms)","trace[355837683] 'compare' (duration: 24.043398ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:21:42.808306Z","caller":"traceutil/trace.go:171","msg":"trace[1510326885] transaction","detail":"{read_only:false; response_revision:8398; number_of_response:1; }","duration":"259.863733ms","start":"2026-06-08T01:21:42.548372Z","end":"2026-06-08T01:21:42.808235Z","steps":["trace[1510326885] 'process raft request' (duration: 259.72039ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:21:43.26304Z","caller":"traceutil/trace.go:171","msg":"trace[1881998671] transaction","detail":"{read_only:false; response_revision:8401; number_of_response:1; }","duration":"117.909582ms","start":"2026-06-08T01:21:43.145105Z","end":"2026-06-08T01:21:43.263014Z","steps":["trace[1881998671] 'process raft request' (duration: 76.199608ms)","trace[1881998671] 'compare' (duration: 41.616002ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:22:11.155091Z","caller":"traceutil/trace.go:171","msg":"trace[258896183] transaction","detail":"{read_only:false; response_revision:8605; number_of_response:1; }","duration":"225.449738ms","start":"2026-06-08T01:22:10.929614Z","end":"2026-06-08T01:22:11.155064Z","steps":["trace[258896183] 'process raft request' (duration: 225.276004ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:22:11.335932Z","caller":"traceutil/trace.go:171","msg":"trace[82678256] transaction","detail":"{read_only:false; response_revision:8606; number_of_response:1; }","duration":"403.29554ms","start":"2026-06-08T01:22:10.932601Z","end":"2026-06-08T01:22:11.335896Z","steps":["trace[82678256] 'process raft request' (duration: 392.844861ms)","trace[82678256] 'compare' (duration: 10.247776ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:22:11.336007Z","caller":"traceutil/trace.go:171","msg":"trace[293930492] transaction","detail":"{read_only:false; response_revision:8607; number_of_response:1; }","duration":"358.60452ms","start":"2026-06-08T01:22:10.97737Z","end":"2026-06-08T01:22:11.335974Z","steps":["trace[293930492] 'process raft request' (duration: 358.448027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:22:11.33624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:22:10.932588Z","time spent":"403.538065ms","remote":"127.0.0.1:50394","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-08T01:22:11.336243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:22:10.977358Z","time spent":"358.782893ms","remote":"127.0.0.1:50394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T01:22:11.337791Z","caller":"traceutil/trace.go:171","msg":"trace[1985039044] linearizableReadLoop","detail":"{readStateIndex:8916; appliedIndex:8914; }","duration":"378.230273ms","start":"2026-06-08T01:22:10.959539Z","end":"2026-06-08T01:22:11.337769Z","steps":["trace[1985039044] 'read index received' (duration: 195.401436ms)","trace[1985039044] 'applied index is now lower than readState.Index' (duration: 182.826197ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:22:11.337972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.629437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T01:22:11.338014Z","caller":"traceutil/trace.go:171","msg":"trace[2035609372] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:8607; }","duration":"361.727339ms","start":"2026-06-08T01:22:10.976276Z","end":"2026-06-08T01:22:11.338003Z","steps":["trace[2035609372] 'agreement among raft nodes before linearized reading' (duration: 361.637388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:22:11.33805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:22:10.976255Z","time spent":"361.78557ms","remote":"127.0.0.1:33810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "} {"level":"warn","ts":"2026-06-08T01:22:11.338029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.462137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-2qlqg\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-06-08T01:22:11.338114Z","caller":"traceutil/trace.go:171","msg":"trace[129574444] range","detail":"{range_begin:/registry/pods/openstack/keepalived-2qlqg; range_end:; response_count:1; response_revision:8607; }","duration":"378.580899ms","start":"2026-06-08T01:22:10.959515Z","end":"2026-06-08T01:22:11.338096Z","steps":["trace[129574444] 'agreement among raft nodes before linearized reading' (duration: 378.333525ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:22:11.338162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:22:10.959503Z","time spent":"378.649781ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6467,"request content":"key:\"/registry/pods/openstack/keepalived-2qlqg\" "} {"level":"warn","ts":"2026-06-08T01:22:11.338193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.310557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T01:22:11.338245Z","caller":"traceutil/trace.go:171","msg":"trace[968671194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8607; }","duration":"101.402298ms","start":"2026-06-08T01:22:11.236831Z","end":"2026-06-08T01:22:11.338233Z","steps":["trace[968671194] 'agreement among raft nodes before linearized reading' (duration: 101.231325ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:22:13.472024Z","caller":"traceutil/trace.go:171","msg":"trace[1120872122] transaction","detail":"{read_only:false; response_revision:8615; number_of_response:1; }","duration":"130.306108ms","start":"2026-06-08T01:22:13.341692Z","end":"2026-06-08T01:22:13.471998Z","steps":["trace[1120872122] 'process raft request' (duration: 130.115725ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:22:13.695235Z","caller":"traceutil/trace.go:171","msg":"trace[1114086025] linearizableReadLoop","detail":"{readStateIndex:8926; appliedIndex:8924; }","duration":"349.505906ms","start":"2026-06-08T01:22:13.345711Z","end":"2026-06-08T01:22:13.695217Z","steps":["trace[1114086025] 'read index received' (duration: 126.2141ms)","trace[1114086025] 'applied index is now lower than readState.Index' (duration: 223.291196ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:22:13.695281Z","caller":"traceutil/trace.go:171","msg":"trace[22233803] transaction","detail":"{read_only:false; response_revision:8616; number_of_response:1; }","duration":"351.483933ms","start":"2026-06-08T01:22:13.343769Z","end":"2026-06-08T01:22:13.695253Z","steps":["trace[22233803] 'process raft request' (duration: 351.28086ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:22:13.695361Z","caller":"traceutil/trace.go:171","msg":"trace[905435841] transaction","detail":"{read_only:false; response_revision:8617; number_of_response:1; }","duration":"341.364231ms","start":"2026-06-08T01:22:13.353964Z","end":"2026-06-08T01:22:13.695328Z","steps":["trace[905435841] 'process raft request' (duration: 341.216668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:22:13.695425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.813404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-2qlqg\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-06-08T01:22:13.695458Z","caller":"traceutil/trace.go:171","msg":"trace[1320183760] range","detail":"{range_begin:/registry/pods/openstack/keepalived-2qlqg; range_end:; response_count:1; response_revision:8617; }","duration":"346.883127ms","start":"2026-06-08T01:22:13.348566Z","end":"2026-06-08T01:22:13.695449Z","steps":["trace[1320183760] 'agreement among raft nodes before linearized reading' (duration: 346.780654ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:22:13.695454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:22:13.343744Z","time spent":"351.641727ms","remote":"127.0.0.1:50394","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-08T01:22:13.69548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:22:13.348554Z","time spent":"346.919727ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6467,"request content":"key:\"/registry/pods/openstack/keepalived-2qlqg\" "} {"level":"warn","ts":"2026-06-08T01:22:13.695519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:22:13.353949Z","time spent":"341.485974ms","remote":"127.0.0.1:50394","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-08T01:22:13.695537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.795992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T01:22:13.695648Z","caller":"traceutil/trace.go:171","msg":"trace[26155430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8617; }","duration":"349.931344ms","start":"2026-06-08T01:22:13.345693Z","end":"2026-06-08T01:22:13.695624Z","steps":["trace[26155430] 'agreement among raft nodes before linearized reading' (duration: 349.660158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:22:13.695717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:22:13.345686Z","time spent":"350.017656ms","remote":"127.0.0.1:50394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-08T01:22:23.826321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.71172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T01:22:23.826442Z","caller":"traceutil/trace.go:171","msg":"trace[443789941] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:8709; }","duration":"207.900763ms","start":"2026-06-08T01:22:23.618516Z","end":"2026-06-08T01:22:23.826417Z","steps":["trace[443789941] 'count revisions from in-memory index tree' (duration: 207.615228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:22:23.826615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.476599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-9757f\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-06-08T01:22:23.826741Z","caller":"traceutil/trace.go:171","msg":"trace[1837641772] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-9757f; range_end:; response_count:1; response_revision:8709; }","duration":"193.619022ms","start":"2026-06-08T01:22:23.633096Z","end":"2026-06-08T01:22:23.826715Z","steps":["trace[1837641772] 'range keys from in-memory index tree' (duration: 193.220515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:22:23.826715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.213204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-08T01:22:23.826973Z","caller":"traceutil/trace.go:171","msg":"trace[1460893367] transaction","detail":"{read_only:false; response_revision:8710; number_of_response:1; }","duration":"193.771505ms","start":"2026-06-08T01:22:23.633173Z","end":"2026-06-08T01:22:23.826944Z","steps":["trace[1460893367] 'process raft request' (duration: 50.224905ms)","trace[1460893367] 'compare' (duration: 143.0184ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:22:23.976005Z","caller":"traceutil/trace.go:171","msg":"trace[1602054305] transaction","detail":"{read_only:false; response_revision:8712; number_of_response:1; }","duration":"142.214524ms","start":"2026-06-08T01:22:23.833742Z","end":"2026-06-08T01:22:23.975957Z","steps":["trace[1602054305] 'process raft request' (duration: 104.624319ms)","trace[1602054305] 'compare' (duration: 37.407901ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:22:24.015201Z","caller":"traceutil/trace.go:171","msg":"trace[963589350] transaction","detail":"{read_only:false; response_revision:8713; number_of_response:1; }","duration":"181.310137ms","start":"2026-06-08T01:22:23.833858Z","end":"2026-06-08T01:22:24.015169Z","steps":["trace[963589350] 'process raft request' (duration: 181.089013ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:22:24.015541Z","caller":"traceutil/trace.go:171","msg":"trace[435873422] transaction","detail":"{read_only:false; response_revision:8714; number_of_response:1; }","duration":"181.266617ms","start":"2026-06-08T01:22:23.834241Z","end":"2026-06-08T01:22:24.015508Z","steps":["trace[435873422] 'process raft request' (duration: 180.873619ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:22:24.015592Z","caller":"traceutil/trace.go:171","msg":"trace[1767996442] transaction","detail":"{read_only:false; response_revision:8715; number_of_response:1; }","duration":"176.792552ms","start":"2026-06-08T01:22:23.838767Z","end":"2026-06-08T01:22:24.01556Z","steps":["trace[1767996442] 'process raft request' (duration: 176.596378ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:22:38.218777Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023c2.wal"} {"level":"info","ts":"2026-06-08T01:23:39.871035Z","caller":"traceutil/trace.go:171","msg":"trace[1721817119] transaction","detail":"{read_only:false; response_revision:9455; number_of_response:1; }","duration":"260.280825ms","start":"2026-06-08T01:23:39.610729Z","end":"2026-06-08T01:23:39.871009Z","steps":["trace[1721817119] 'process raft request' (duration: 260.107351ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:23:39.95109Z","caller":"traceutil/trace.go:171","msg":"trace[1998666631] transaction","detail":"{read_only:false; response_revision:9456; number_of_response:1; }","duration":"338.067733ms","start":"2026-06-08T01:23:39.613007Z","end":"2026-06-08T01:23:39.951075Z","steps":["trace[1998666631] 'process raft request' (duration: 325.092816ms)","trace[1998666631] 'compare' (duration: 12.823794ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:23:39.951228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:23:39.612991Z","time spent":"338.147895ms","remote":"127.0.0.1:50394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T01:23:39.951378Z","caller":"traceutil/trace.go:171","msg":"trace[675261530] transaction","detail":"{read_only:false; response_revision:9457; number_of_response:1; }","duration":"135.116117ms","start":"2026-06-08T01:23:39.816209Z","end":"2026-06-08T01:23:39.951325Z","steps":["trace[675261530] 'process raft request' (duration: 134.824501ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:24:08.045653Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e98569549cc430c","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-08T01:24:08.050809Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-08T01:24:08.050929Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-08T01:26:15.742155Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8118} {"level":"info","ts":"2026-06-08T01:26:15.804278Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8118,"took":"59.431759ms","hash":2257124321,"current-db-size-bytes":56483840,"current-db-size":"56 MB","current-db-size-in-use-bytes":29458432,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-08T01:26:15.804341Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2257124321,"revision":8118,"compact-revision":6031} {"level":"info","ts":"2026-06-08T01:27:23.373328Z","caller":"traceutil/trace.go:171","msg":"trace[31668756] transaction","detail":"{read_only:false; response_revision:11304; number_of_response:1; }","duration":"112.747213ms","start":"2026-06-08T01:27:23.260549Z","end":"2026-06-08T01:27:23.373297Z","steps":["trace[31668756] 'process raft request' (duration: 112.55029ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:27:23.76621Z","caller":"traceutil/trace.go:171","msg":"trace[1378231228] transaction","detail":"{read_only:false; response_revision:11306; number_of_response:1; }","duration":"189.446132ms","start":"2026-06-08T01:27:23.576738Z","end":"2026-06-08T01:27:23.766184Z","steps":["trace[1378231228] 'process raft request' (duration: 189.244198ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:27:23.781771Z","caller":"traceutil/trace.go:171","msg":"trace[325471058] transaction","detail":"{read_only:false; response_revision:11307; number_of_response:1; }","duration":"204.829754ms","start":"2026-06-08T01:27:23.57692Z","end":"2026-06-08T01:27:23.781749Z","steps":["trace[325471058] 'process raft request' (duration: 204.317265ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:27:23.781945Z","caller":"traceutil/trace.go:171","msg":"trace[1246818115] transaction","detail":"{read_only:false; response_revision:11308; number_of_response:1; }","duration":"201.527802ms","start":"2026-06-08T01:27:23.5804Z","end":"2026-06-08T01:27:23.781928Z","steps":["trace[1246818115] 'process raft request' (duration: 200.999072ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:27:23.900412Z","caller":"traceutil/trace.go:171","msg":"trace[111450397] transaction","detail":"{read_only:false; response_revision:11309; number_of_response:1; }","duration":"110.703965ms","start":"2026-06-08T01:27:23.789683Z","end":"2026-06-08T01:27:23.900387Z","steps":["trace[111450397] 'process raft request' (duration: 53.123721ms)","trace[111450397] 'compare' (duration: 57.37806ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:31:15.747611Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10709} {"level":"info","ts":"2026-06-08T01:31:15.825581Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10709,"took":"75.246361ms","hash":1535657427,"current-db-size-bytes":56483840,"current-db-size":"56 MB","current-db-size-in-use-bytes":27164672,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-08T01:31:15.825647Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1535657427,"revision":10709,"compact-revision":8118} {"level":"info","ts":"2026-06-08T01:33:14.214909Z","caller":"traceutil/trace.go:171","msg":"trace[1812761131] transaction","detail":"{read_only:false; response_revision:13703; number_of_response:1; }","duration":"104.531408ms","start":"2026-06-08T01:33:14.110353Z","end":"2026-06-08T01:33:14.214884Z","steps":["trace[1812761131] 'process raft request' (duration: 104.379205ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:33:14.215378Z","caller":"traceutil/trace.go:171","msg":"trace[504648650] transaction","detail":"{read_only:false; response_revision:13704; number_of_response:1; }","duration":"103.837474ms","start":"2026-06-08T01:33:14.111525Z","end":"2026-06-08T01:33:14.215363Z","steps":["trace[504648650] 'process raft request' (duration: 103.743492ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:33:35.848199Z","caller":"traceutil/trace.go:171","msg":"trace[1023620661] linearizableReadLoop","detail":"{readStateIndex:14295; appliedIndex:14293; }","duration":"134.775553ms","start":"2026-06-08T01:33:35.713398Z","end":"2026-06-08T01:33:35.848173Z","steps":["trace[1023620661] 'read index received' (duration: 8.011482ms)","trace[1023620661] 'applied index is now lower than readState.Index' (duration: 126.761411ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:33:35.848282Z","caller":"traceutil/trace.go:171","msg":"trace[1862767805] transaction","detail":"{read_only:false; response_revision:13819; number_of_response:1; }","duration":"174.692322ms","start":"2026-06-08T01:33:35.673538Z","end":"2026-06-08T01:33:35.84823Z","steps":["trace[1862767805] 'process raft request' (duration: 174.495218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:33:35.848485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.040697ms","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-08T01:33:35.848598Z","caller":"traceutil/trace.go:171","msg":"trace[354290661] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13819; }","duration":"135.221811ms","start":"2026-06-08T01:33:35.713349Z","end":"2026-06-08T01:33:35.848571Z","steps":["trace[354290661] 'agreement among raft nodes before linearized reading' (duration: 134.918425ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:33:51.576323Z","caller":"traceutil/trace.go:171","msg":"trace[1073955266] transaction","detail":"{read_only:false; response_revision:13913; number_of_response:1; }","duration":"363.452701ms","start":"2026-06-08T01:33:51.212844Z","end":"2026-06-08T01:33:51.576297Z","steps":["trace[1073955266] 'process raft request' (duration: 363.238567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:33:51.576483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T01:33:51.212816Z","time spent":"363.589724ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11815,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T01:33:51.585312Z","caller":"traceutil/trace.go:171","msg":"trace[32807520] linearizableReadLoop","detail":"{readStateIndex:14394; appliedIndex:14392; }","duration":"171.291347ms","start":"2026-06-08T01:33:51.414007Z","end":"2026-06-08T01:33:51.585298Z","steps":["trace[32807520] 'read index received' (duration: 162.195573ms)","trace[32807520] 'applied index is now lower than readState.Index' (duration: 9.094914ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:33:51.585431Z","caller":"traceutil/trace.go:171","msg":"trace[839571685] transaction","detail":"{read_only:false; response_revision:13914; number_of_response:1; }","duration":"241.897281ms","start":"2026-06-08T01:33:51.34351Z","end":"2026-06-08T01:33:51.585407Z","steps":["trace[839571685] 'process raft request' (duration: 241.716168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:33:51.585445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.428779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T01:33:51.585517Z","caller":"traceutil/trace.go:171","msg":"trace[1374080291] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:13914; }","duration":"171.508121ms","start":"2026-06-08T01:33:51.413988Z","end":"2026-06-08T01:33:51.585496Z","steps":["trace[1374080291] 'agreement among raft nodes before linearized reading' (duration: 171.393369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:33:51.585461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.22552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-08T01:33:51.585601Z","caller":"traceutil/trace.go:171","msg":"trace[1462898361] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:13914; }","duration":"157.418903ms","start":"2026-06-08T01:33:51.428169Z","end":"2026-06-08T01:33:51.585588Z","steps":["trace[1462898361] 'agreement among raft nodes before linearized reading' (duration: 157.204979ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:35:42.689411Z","caller":"traceutil/trace.go:171","msg":"trace[872387130] linearizableReadLoop","detail":"{readStateIndex:15702; appliedIndex:15700; }","duration":"116.373734ms","start":"2026-06-08T01:35:42.573017Z","end":"2026-06-08T01:35:42.689391Z","steps":["trace[872387130] 'read index received' (duration: 92.288286ms)","trace[872387130] 'applied index is now lower than readState.Index' (duration: 24.084728ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:35:42.689525Z","caller":"traceutil/trace.go:171","msg":"trace[1504401284] transaction","detail":"{read_only:false; response_revision:15182; number_of_response:1; }","duration":"168.584827ms","start":"2026-06-08T01:35:42.520931Z","end":"2026-06-08T01:35:42.689516Z","steps":["trace[1504401284] 'process raft request' (duration: 144.379767ms)","trace[1504401284] 'compare' (duration: 23.749672ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T01:35:42.689723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.45143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T01:35:42.689753Z","caller":"traceutil/trace.go:171","msg":"trace[991312522] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15183; }","duration":"110.555344ms","start":"2026-06-08T01:35:42.579191Z","end":"2026-06-08T01:35:42.689746Z","steps":["trace[991312522] 'agreement among raft nodes before linearized reading' (duration: 110.473451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:35:42.68975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.709371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T01:35:42.689847Z","caller":"traceutil/trace.go:171","msg":"trace[1534908832] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15183; }","duration":"116.838903ms","start":"2026-06-08T01:35:42.572985Z","end":"2026-06-08T01:35:42.689824Z","steps":["trace[1534908832] 'agreement among raft nodes before linearized reading' (duration: 116.570027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:35:42.689958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.555058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-06-08T01:35:42.689986Z","caller":"traceutil/trace.go:171","msg":"trace[1158453344] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15183; }","duration":"105.602369ms","start":"2026-06-08T01:35:42.584377Z","end":"2026-06-08T01:35:42.68998Z","steps":["trace[1158453344] 'agreement among raft nodes before linearized reading' (duration: 105.505477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:35:42.690147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.856301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T01:35:42.690171Z","caller":"traceutil/trace.go:171","msg":"trace[1624933963] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15183; }","duration":"108.939612ms","start":"2026-06-08T01:35:42.581226Z","end":"2026-06-08T01:35:42.690166Z","steps":["trace[1624933963] 'agreement among raft nodes before linearized reading' (duration: 108.895741ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:35:42.69036Z","caller":"traceutil/trace.go:171","msg":"trace[146367313] transaction","detail":"{read_only:false; response_revision:15183; number_of_response:1; }","duration":"168.71489ms","start":"2026-06-08T01:35:42.521636Z","end":"2026-06-08T01:35:42.690351Z","steps":["trace[146367313] 'process raft request' (duration: 167.673069ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:36:15.754896Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12812} {"level":"info","ts":"2026-06-08T01:36:15.859546Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12812,"took":"101.894298ms","hash":3421043850,"current-db-size-bytes":56483840,"current-db-size":"56 MB","current-db-size-in-use-bytes":30539776,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-08T01:36:15.859612Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3421043850,"revision":12812,"compact-revision":10709} {"level":"info","ts":"2026-06-08T01:41:15.76027Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15387} {"level":"info","ts":"2026-06-08T01:41:15.852059Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15387,"took":"88.810549ms","hash":3989746411,"current-db-size-bytes":56483840,"current-db-size":"56 MB","current-db-size-in-use-bytes":32444416,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-08T01:41:15.852124Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3989746411,"revision":15387,"compact-revision":12812} {"level":"info","ts":"2026-06-08T01:41:16.685098Z","caller":"traceutil/trace.go:171","msg":"trace[1570759727] linearizableReadLoop","detail":"{readStateIndex:18317; appliedIndex:18316; }","duration":"150.709426ms","start":"2026-06-08T01:41:16.534355Z","end":"2026-06-08T01:41:16.685064Z","steps":["trace[1570759727] 'read index received' (duration: 83.757923ms)","trace[1570759727] 'applied index is now lower than readState.Index' (duration: 66.949993ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:41:16.68518Z","caller":"traceutil/trace.go:171","msg":"trace[305245109] transaction","detail":"{read_only:false; response_revision:17713; number_of_response:1; }","duration":"156.900573ms","start":"2026-06-08T01:41:16.528241Z","end":"2026-06-08T01:41:16.685142Z","steps":["trace[305245109] 'process raft request' (duration: 156.633597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:41:16.685403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.008141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-08T01:41:16.685449Z","caller":"traceutil/trace.go:171","msg":"trace[1308701857] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:17713; }","duration":"151.108094ms","start":"2026-06-08T01:41:16.534329Z","end":"2026-06-08T01:41:16.685437Z","steps":["trace[1308701857] 'agreement among raft nodes before linearized reading' (duration: 150.88633ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:41:16.68606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.998226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T01:41:16.686118Z","caller":"traceutil/trace.go:171","msg":"trace[1095640876] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:17715; }","duration":"146.094718ms","start":"2026-06-08T01:41:16.54001Z","end":"2026-06-08T01:41:16.686105Z","steps":["trace[1095640876] 'agreement among raft nodes before linearized reading' (duration: 145.975546ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:44:39.133543Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e98569549cc430c","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-08T01:44:39.137841Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-08T01:44:39.137968Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-08T01:46:15.769208Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17698} {"level":"info","ts":"2026-06-08T01:46:15.859819Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17698,"took":"87.734237ms","hash":914626648,"current-db-size-bytes":56483840,"current-db-size":"56 MB","current-db-size-in-use-bytes":34340864,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-08T01:46:15.859892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":914626648,"revision":17698,"compact-revision":15387} {"level":"info","ts":"2026-06-08T01:46:41.76928Z","caller":"traceutil/trace.go:171","msg":"trace[799131245] transaction","detail":"{read_only:false; response_revision:20244; number_of_response:1; }","duration":"137.765569ms","start":"2026-06-08T01:46:41.631475Z","end":"2026-06-08T01:46:41.769241Z","steps":["trace[799131245] 'process raft request' (duration: 137.562605ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:46:52.18143Z","caller":"traceutil/trace.go:171","msg":"trace[1032090553] transaction","detail":"{read_only:false; response_revision:20297; number_of_response:1; }","duration":"180.229144ms","start":"2026-06-08T01:46:52.001167Z","end":"2026-06-08T01:46:52.181396Z","steps":["trace[1032090553] 'process raft request' (duration: 179.991329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:46:58.113535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.989041ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-08T01:46:58.113783Z","caller":"traceutil/trace.go:171","msg":"trace[2102716771] transaction","detail":"{read_only:false; response_revision:20328; number_of_response:1; }","duration":"172.11366ms","start":"2026-06-08T01:46:57.94165Z","end":"2026-06-08T01:46:58.113764Z","steps":["trace[2102716771] 'process raft request' (duration: 13.777632ms)","trace[2102716771] 'compare' (duration: 157.731056ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:46:58.113899Z","caller":"traceutil/trace.go:171","msg":"trace[1220592811] transaction","detail":"{read_only:false; response_revision:20329; number_of_response:1; }","duration":"134.14609ms","start":"2026-06-08T01:46:57.979713Z","end":"2026-06-08T01:46:58.113859Z","steps":["trace[1220592811] 'process raft request' (duration: 133.926215ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:46:58.37043Z","caller":"traceutil/trace.go:171","msg":"trace[1034966475] transaction","detail":"{read_only:false; response_revision:20330; number_of_response:1; }","duration":"254.123438ms","start":"2026-06-08T01:46:58.116282Z","end":"2026-06-08T01:46:58.370405Z","steps":["trace[1034966475] 'process raft request' (duration: 160.216474ms)","trace[1034966475] 'compare' (duration: 93.69149ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:46:58.370616Z","caller":"traceutil/trace.go:171","msg":"trace[1114318614] linearizableReadLoop","detail":"{readStateIndex:21020; appliedIndex:21018; }","duration":"168.343379ms","start":"2026-06-08T01:46:58.202241Z","end":"2026-06-08T01:46:58.370585Z","steps":["trace[1114318614] 'read index received' (duration: 74.174579ms)","trace[1114318614] 'applied index is now lower than readState.Index' (duration: 94.142549ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T01:46:58.370691Z","caller":"traceutil/trace.go:171","msg":"trace[1631091821] transaction","detail":"{read_only:false; response_revision:20331; number_of_response:1; }","duration":"252.916316ms","start":"2026-06-08T01:46:58.11775Z","end":"2026-06-08T01:46:58.370666Z","steps":["trace[1631091821] 'process raft request' (duration: 252.57983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T01:46:58.370853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.594453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-08T01:46:58.370892Z","caller":"traceutil/trace.go:171","msg":"trace[2097339648] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20331; }","duration":"168.680684ms","start":"2026-06-08T01:46:58.202197Z","end":"2026-06-08T01:46:58.370878Z","steps":["trace[2097339648] 'agreement among raft nodes before linearized reading' (duration: 168.47979ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:46:58.679289Z","caller":"traceutil/trace.go:171","msg":"trace[870883374] transaction","detail":"{read_only:false; response_revision:20333; number_of_response:1; }","duration":"131.721853ms","start":"2026-06-08T01:46:58.547535Z","end":"2026-06-08T01:46:58.679256Z","steps":["trace[870883374] 'process raft request' (duration: 131.57266ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T01:51:15.774758Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20110} {"level":"info","ts":"2026-06-08T01:51:15.883672Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20110,"took":"105.904032ms","hash":1787787360,"current-db-size-bytes":56483840,"current-db-size":"56 MB","current-db-size-in-use-bytes":31936512,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-08T01:51:15.883744Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1787787360,"revision":20110,"compact-revision":17698}