{"level":"warn","ts":"2026-06-22T01:49:47.918595Z","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-22T01:49:47.918698Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-22T01:49:47.918777Z","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-22T01:49:47.918792Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-06-22T01:49:47.918814Z","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-22T01:49:47.919685Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-06-22T01:49:47.919803Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-22T01:49:47.92439Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.269736ms"} {"level":"info","ts":"2026-06-22T01:49:47.932016Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-06-22T01:49:47.932117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-06-22T01:49:47.932186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-06-22T01:49:47.932203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-22T01:49:47.932216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-06-22T01:49:47.932343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-06-22T01:49:47.94128Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-22T01:49:47.94381Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-22T01:49:47.944927Z","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-22T01:49:47.947748Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-22T01:49:47.953741Z","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-22T01:49:47.954416Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-22T01:49:47.954504Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-22T01:49:47.956005Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-06-22T01:49:47.95605Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-06-22T01:49:47.956109Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-22T01:49:47.956415Z","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-22T01:49:47.956654Z","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-22T01:49:47.956712Z","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-22T01:49:47.957124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-06-22T01:49:47.95727Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-06-22T01:49:48.334082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-06-22T01:49:48.334138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-06-22T01:49:48.334179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-06-22T01:49:48.334204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-06-22T01:49:48.334216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-06-22T01:49:48.33425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-06-22T01:49:48.334263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-06-22T01:49:48.363248Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-06-22T01:49:48.363453Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T01:49:48.363612Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:49:48.363714Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-22T01:49:48.363777Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-22T01:49:48.363417Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T01:49:48.366572Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-22T01:49:48.368959Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-06-22T01:49:48.407787Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:49:48.407915Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:49:48.407969Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:49:58.991236Z","caller":"traceutil/trace.go:171","msg":"trace[62117653] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"112.041518ms","start":"2026-06-22T01:49:58.879168Z","end":"2026-06-22T01:49:58.99121Z","steps":["trace[62117653] 'process raft request' (duration: 111.913984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:59.349036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.579852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-06-22T01:49:59.349113Z","caller":"traceutil/trace.go:171","msg":"trace[1207280033] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:353; }","duration":"281.696885ms","start":"2026-06-22T01:49:59.067401Z","end":"2026-06-22T01:49:59.349098Z","steps":["trace[1207280033] 'range keys from in-memory index tree' (duration: 281.452548ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:59.534891Z","caller":"traceutil/trace.go:171","msg":"trace[1172409775] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"177.6059ms","start":"2026-06-22T01:49:59.357261Z","end":"2026-06-22T01:49:59.534867Z","steps":["trace[1172409775] 'process raft request' (duration: 177.425305ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:50:32.162833Z","caller":"traceutil/trace.go:171","msg":"trace[1502219980] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"140.511829ms","start":"2026-06-22T01:50:32.022251Z","end":"2026-06-22T01:50:32.162763Z","steps":["trace[1502219980] 'process raft request' (duration: 139.595461ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:50:32.66673Z","caller":"traceutil/trace.go:171","msg":"trace[942836594] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"419.396681ms","start":"2026-06-22T01:50:32.247279Z","end":"2026-06-22T01:50:32.666675Z","steps":["trace[942836594] 'read index received' (duration: 405.332247ms)","trace[942836594] 'applied index is now lower than readState.Index' (duration: 14.062634ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:50:32.666989Z","caller":"traceutil/trace.go:171","msg":"trace[1535500769] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"447.076304ms","start":"2026-06-22T01:50:32.219885Z","end":"2026-06-22T01:50:32.666961Z","steps":["trace[1535500769] 'process raft request' (duration: 432.821385ms)","trace[1535500769] 'compare' (duration: 13.529068ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:50:32.667214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.088968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-b5vfx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-22T01:50:32.66727Z","caller":"traceutil/trace.go:171","msg":"trace[457938220] range","detail":"{range_begin:/registry/pods/kube-system/cilium-b5vfx; range_end:; response_count:1; response_revision:596; }","duration":"285.1759ms","start":"2026-06-22T01:50:32.382079Z","end":"2026-06-22T01:50:32.667255Z","steps":["trace[457938220] 'agreement among raft nodes before linearized reading' (duration: 284.961564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:50:32.667215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.904766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-22T01:50:32.667355Z","caller":"traceutil/trace.go:171","msg":"trace[110266674] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:596; }","duration":"420.089611ms","start":"2026-06-22T01:50:32.247251Z","end":"2026-06-22T01:50:32.667341Z","steps":["trace[110266674] 'agreement among raft nodes before linearized reading' (duration: 419.683139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:50:32.6674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:50:32.247235Z","time spent":"420.154133ms","remote":"127.0.0.1:49380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-22T01:50:32.667494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:50:32.219861Z","time spent":"447.165037ms","remote":"127.0.0.1:49596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T01:50:32.667547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.51174ms","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-22T01:50:32.667626Z","caller":"traceutil/trace.go:171","msg":"trace[718002865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:596; }","duration":"206.654794ms","start":"2026-06-22T01:50:32.460948Z","end":"2026-06-22T01:50:32.667603Z","steps":["trace[718002865] 'agreement among raft nodes before linearized reading' (duration: 206.375434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:50:47.674055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.197814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9cw2f\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-22T01:50:47.674147Z","caller":"traceutil/trace.go:171","msg":"trace[281699664] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9cw2f; range_end:; response_count:1; response_revision:759; }","duration":"199.342446ms","start":"2026-06-22T01:50:47.474786Z","end":"2026-06-22T01:50:47.674128Z","steps":["trace[281699664] 'range keys from in-memory index tree' (duration: 198.971962ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:21.062623Z","caller":"traceutil/trace.go:171","msg":"trace[1502856078] linearizableReadLoop","detail":"{readStateIndex:1210; appliedIndex:1209; }","duration":"135.968111ms","start":"2026-06-22T01:51:20.926628Z","end":"2026-06-22T01:51:21.062596Z","steps":["trace[1502856078] 'read index received' (duration: 135.93699ms)","trace[1502856078] 'applied index is now lower than readState.Index' (duration: 29.991µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:51:21.062722Z","caller":"traceutil/trace.go:171","msg":"trace[1718734099] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"139.529614ms","start":"2026-06-22T01:51:20.923141Z","end":"2026-06-22T01:51:21.06267Z","steps":["trace[1718734099] 'process raft request' (duration: 139.28182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:51:21.063456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.458079ms","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-22T01:51:21.063564Z","caller":"traceutil/trace.go:171","msg":"trace[593056041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1171; }","duration":"136.960898ms","start":"2026-06-22T01:51:20.926585Z","end":"2026-06-22T01:51:21.063546Z","steps":["trace[593056041] 'agreement among raft nodes before linearized reading' (duration: 136.137984ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:21.313812Z","caller":"traceutil/trace.go:171","msg":"trace[1094858503] linearizableReadLoop","detail":"{readStateIndex:1211; appliedIndex:1210; }","duration":"243.874403ms","start":"2026-06-22T01:51:21.069906Z","end":"2026-06-22T01:51:21.31378Z","steps":["trace[1094858503] 'read index received' (duration: 207.104225ms)","trace[1094858503] 'applied index is now lower than readState.Index' (duration: 36.769118ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:51:21.314064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.119807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-06-22T01:51:21.314126Z","caller":"traceutil/trace.go:171","msg":"trace[2142509687] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1172; }","duration":"244.23395ms","start":"2026-06-22T01:51:21.069874Z","end":"2026-06-22T01:51:21.314108Z","steps":["trace[2142509687] 'agreement among raft nodes before linearized reading' (duration: 244.067027ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:21.314631Z","caller":"traceutil/trace.go:171","msg":"trace[1170308575] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"245.288669ms","start":"2026-06-22T01:51:21.068968Z","end":"2026-06-22T01:51:21.314257Z","steps":["trace[1170308575] 'process raft request' (duration: 207.929291ms)","trace[1170308575] 'compare' (duration: 36.735677ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:52:08.057283Z","caller":"traceutil/trace.go:171","msg":"trace[1718038224] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"112.404109ms","start":"2026-06-22T01:52:07.944848Z","end":"2026-06-22T01:52:08.057252Z","steps":["trace[1718038224] 'process raft request' (duration: 99.943939ms)","trace[1718038224] 'compare' (duration: 11.868316ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:52:08.434884Z","caller":"traceutil/trace.go:171","msg":"trace[1488109813] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"368.942744ms","start":"2026-06-22T01:52:08.065908Z","end":"2026-06-22T01:52:08.434851Z","steps":["trace[1488109813] 'process raft request' (duration: 368.733558ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:52:08.435239Z","caller":"traceutil/trace.go:171","msg":"trace[87184164] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"369.056546ms","start":"2026-06-22T01:52:08.066165Z","end":"2026-06-22T01:52:08.435222Z","steps":["trace[87184164] 'process raft request' (duration: 368.634066ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:52:08.435471Z","caller":"traceutil/trace.go:171","msg":"trace[239651603] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"368.974254ms","start":"2026-06-22T01:52:08.066457Z","end":"2026-06-22T01:52:08.435432Z","steps":["trace[239651603] 'process raft request' (duration: 368.715418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:52:08.435783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:52:08.066155Z","time spent":"369.168849ms","remote":"127.0.0.1:49394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:52:08.435808Z","caller":"traceutil/trace.go:171","msg":"trace[1695060194] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"369.188789ms","start":"2026-06-22T01:52:08.066604Z","end":"2026-06-22T01:52:08.435793Z","steps":["trace[1695060194] 'process raft request' (duration: 368.720739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:52:08.436203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:52:08.066433Z","time spent":"369.142968ms","remote":"127.0.0.1:49284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T01:52:08.436271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:52:08.066595Z","time spent":"369.600258ms","remote":"127.0.0.1:49206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T01:52:08.436613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:52:08.065896Z","time spent":"369.22032ms","remote":"127.0.0.1:49394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1513,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:52:08.602341Z","caller":"traceutil/trace.go:171","msg":"trace[1143111090] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"151.078959ms","start":"2026-06-22T01:52:08.451231Z","end":"2026-06-22T01:52:08.60231Z","steps":["trace[1143111090] 'process raft request' (duration: 81.042857ms)","trace[1143111090] 'compare' (duration: 69.831257ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:52:08.602324Z","caller":"traceutil/trace.go:171","msg":"trace[1446350810] linearizableReadLoop","detail":"{readStateIndex:1893; appliedIndex:1891; }","duration":"129.15646ms","start":"2026-06-22T01:52:08.473135Z","end":"2026-06-22T01:52:08.602291Z","steps":["trace[1446350810] 'read index received' (duration: 27.558258ms)","trace[1446350810] 'applied index is now lower than readState.Index' (duration: 101.597092ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:52:08.602529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.357626ms","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-22T01:52:08.602837Z","caller":"traceutil/trace.go:171","msg":"trace[1299495759] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1836; }","duration":"129.55489ms","start":"2026-06-22T01:52:08.47307Z","end":"2026-06-22T01:52:08.602625Z","steps":["trace[1299495759] 'agreement among raft nodes before linearized reading' (duration: 129.333965ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:52:41.31752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.942092ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T01:52:41.317697Z","caller":"traceutil/trace.go:171","msg":"trace[800874644] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"283.561139ms","start":"2026-06-22T01:52:41.034108Z","end":"2026-06-22T01:52:41.317669Z","steps":["trace[800874644] 'process raft request' (duration: 148.996941ms)","trace[800874644] 'compare' (duration: 133.707365ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:52:41.660187Z","caller":"traceutil/trace.go:171","msg":"trace[1921637434] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"108.415172ms","start":"2026-06-22T01:52:41.551743Z","end":"2026-06-22T01:52:41.660159Z","steps":["trace[1921637434] 'process raft request' (duration: 108.181016ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:34.091238Z","caller":"traceutil/trace.go:171","msg":"trace[1720132980] transaction","detail":"{read_only:false; response_revision:2568; number_of_response:1; }","duration":"194.528296ms","start":"2026-06-22T01:53:33.896693Z","end":"2026-06-22T01:53:34.091221Z","steps":["trace[1720132980] 'process raft request' (duration: 159.736556ms)","trace[1720132980] 'compare' (duration: 34.497632ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:56:33.109798Z","caller":"traceutil/trace.go:171","msg":"trace[1279917460] transaction","detail":"{read_only:false; response_revision:4476; number_of_response:1; }","duration":"149.770852ms","start":"2026-06-22T01:56:32.959997Z","end":"2026-06-22T01:56:33.109768Z","steps":["trace[1279917460] 'process raft request' (duration: 149.603019ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:33.201827Z","caller":"traceutil/trace.go:171","msg":"trace[1751106214] linearizableReadLoop","detail":"{readStateIndex:4674; appliedIndex:4672; }","duration":"236.938186ms","start":"2026-06-22T01:56:32.964858Z","end":"2026-06-22T01:56:33.201796Z","steps":["trace[1751106214] 'read index received' (duration: 145.311524ms)","trace[1751106214] 'applied index is now lower than readState.Index' (duration: 91.625332ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:56:33.202109Z","caller":"traceutil/trace.go:171","msg":"trace[1422214937] transaction","detail":"{read_only:false; response_revision:4478; number_of_response:1; }","duration":"240.279051ms","start":"2026-06-22T01:56:32.961813Z","end":"2026-06-22T01:56:33.202092Z","steps":["trace[1422214937] 'process raft request' (duration: 239.807182ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:33.202197Z","caller":"traceutil/trace.go:171","msg":"trace[1562345752] transaction","detail":"{read_only:false; response_revision:4477; number_of_response:1; }","duration":"241.897072ms","start":"2026-06-22T01:56:32.960271Z","end":"2026-06-22T01:56:33.202168Z","steps":["trace[1562345752] 'process raft request' (duration: 206.631398ms)","trace[1562345752] 'compare' (duration: 34.52532ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:56:33.202355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.047867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-22T01:56:33.20243Z","caller":"traceutil/trace.go:171","msg":"trace[1540975295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4479; }","duration":"186.142849ms","start":"2026-06-22T01:56:33.016268Z","end":"2026-06-22T01:56:33.202411Z","steps":["trace[1540975295] 'agreement among raft nodes before linearized reading' (duration: 185.888064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:33.202465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.587018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-22T01:56:33.202529Z","caller":"traceutil/trace.go:171","msg":"trace[1648018528] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4479; }","duration":"237.683171ms","start":"2026-06-22T01:56:32.964832Z","end":"2026-06-22T01:56:33.202516Z","steps":["trace[1648018528] 'agreement among raft nodes before linearized reading' (duration: 237.258422ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:33.202671Z","caller":"traceutil/trace.go:171","msg":"trace[776665209] transaction","detail":"{read_only:false; response_revision:4479; number_of_response:1; }","duration":"160.386622ms","start":"2026-06-22T01:56:33.042272Z","end":"2026-06-22T01:56:33.202658Z","steps":["trace[776665209] 'process raft request' (duration: 159.457284ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:33.524003Z","caller":"traceutil/trace.go:171","msg":"trace[1354790624] linearizableReadLoop","detail":"{readStateIndex:4686; appliedIndex:4685; }","duration":"176.303226ms","start":"2026-06-22T01:56:33.347673Z","end":"2026-06-22T01:56:33.523976Z","steps":["trace[1354790624] 'read index received' (duration: 9.230842ms)","trace[1354790624] 'applied index is now lower than readState.Index' (duration: 167.071384ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:56:33.524147Z","caller":"traceutil/trace.go:171","msg":"trace[1724907198] transaction","detail":"{read_only:false; response_revision:4489; number_of_response:1; }","duration":"177.768665ms","start":"2026-06-22T01:56:33.346331Z","end":"2026-06-22T01:56:33.5241Z","steps":["trace[1724907198] 'process raft request' (duration: 177.45891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:33.524223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.52038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-06-22T01:56:33.524265Z","caller":"traceutil/trace.go:171","msg":"trace[1863509943] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4489; }","duration":"176.620341ms","start":"2026-06-22T01:56:33.347632Z","end":"2026-06-22T01:56:33.524252Z","steps":["trace[1863509943] 'agreement among raft nodes before linearized reading' (duration: 176.451148ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:33.631457Z","caller":"traceutil/trace.go:171","msg":"trace[100805201] linearizableReadLoop","detail":"{readStateIndex:4687; appliedIndex:4686; }","duration":"101.171528ms","start":"2026-06-22T01:56:33.530264Z","end":"2026-06-22T01:56:33.631436Z","steps":["trace[100805201] 'read index received' (duration: 95.068118ms)","trace[100805201] 'applied index is now lower than readState.Index' (duration: 6.10271ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:56:33.631899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.588907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:568"} {"level":"info","ts":"2026-06-22T01:56:33.631985Z","caller":"traceutil/trace.go:171","msg":"trace[1975896408] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4490; }","duration":"101.7386ms","start":"2026-06-22T01:56:33.530226Z","end":"2026-06-22T01:56:33.631964Z","steps":["trace[1975896408] 'agreement among raft nodes before linearized reading' (duration: 101.338302ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:33.632122Z","caller":"traceutil/trace.go:171","msg":"trace[1749829451] transaction","detail":"{read_only:false; response_revision:4490; number_of_response:1; }","duration":"137.791688ms","start":"2026-06-22T01:56:33.493694Z","end":"2026-06-22T01:56:33.631486Z","steps":["trace[1749829451] 'process raft request' (duration: 131.688088ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:33.799945Z","caller":"traceutil/trace.go:171","msg":"trace[1400815096] linearizableReadLoop","detail":"{readStateIndex:4689; appliedIndex:4687; }","duration":"156.722891ms","start":"2026-06-22T01:56:33.643193Z","end":"2026-06-22T01:56:33.799916Z","steps":["trace[1400815096] 'read index received' (duration: 14.734151ms)","trace[1400815096] 'applied index is now lower than readState.Index' (duration: 141.98772ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:56:33.80002Z","caller":"traceutil/trace.go:171","msg":"trace[635472606] transaction","detail":"{read_only:false; response_revision:4492; number_of_response:1; }","duration":"160.003575ms","start":"2026-06-22T01:56:33.639988Z","end":"2026-06-22T01:56:33.799991Z","steps":["trace[635472606] 'process raft request' (duration: 101.866343ms)","trace[635472606] 'compare' (duration: 57.932538ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:56:33.800692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.024433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:568"} {"level":"info","ts":"2026-06-22T01:56:33.800982Z","caller":"traceutil/trace.go:171","msg":"trace[2094599572] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4492; }","duration":"140.361449ms","start":"2026-06-22T01:56:33.660605Z","end":"2026-06-22T01:56:33.800967Z","steps":["trace[2094599572] 'agreement among raft nodes before linearized reading' (duration: 139.835969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:33.801215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.949136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4830"} {"level":"info","ts":"2026-06-22T01:56:33.801395Z","caller":"traceutil/trace.go:171","msg":"trace[2069846923] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4492; }","duration":"158.21245ms","start":"2026-06-22T01:56:33.643162Z","end":"2026-06-22T01:56:33.801374Z","steps":["trace[2069846923] 'agreement among raft nodes before linearized reading' (duration: 156.973505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:39.861859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.586472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-745d7a6b-ac63-4883-878c-dfce22266c50\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-22T01:56:39.861969Z","caller":"traceutil/trace.go:171","msg":"trace[230022597] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-745d7a6b-ac63-4883-878c-dfce22266c50; range_end:; response_count:1; response_revision:4639; }","duration":"233.700314ms","start":"2026-06-22T01:56:39.628213Z","end":"2026-06-22T01:56:39.861913Z","steps":["trace[230022597] 'range keys from in-memory index tree' (duration: 233.410349ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:39.862061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.366829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:56:39.862137Z","caller":"traceutil/trace.go:171","msg":"trace[1863668268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4639; }","duration":"207.516641ms","start":"2026-06-22T01:56:39.654602Z","end":"2026-06-22T01:56:39.862119Z","steps":["trace[1863668268] 'range keys from in-memory index tree' (duration: 207.228576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:39.862163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.524756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3465"} {"level":"info","ts":"2026-06-22T01:56:39.862251Z","caller":"traceutil/trace.go:171","msg":"trace[1653862559] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4639; }","duration":"354.646157ms","start":"2026-06-22T01:56:39.507573Z","end":"2026-06-22T01:56:39.862219Z","steps":["trace[1653862559] 'range keys from in-memory index tree' (duration: 354.323481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:39.862299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:56:39.507557Z","time spent":"354.73168ms","remote":"127.0.0.1:49200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3488,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-06-22T01:56:39.862332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.478356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:56:39.862439Z","caller":"traceutil/trace.go:171","msg":"trace[1705851065] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4639; }","duration":"317.632119ms","start":"2026-06-22T01:56:39.544788Z","end":"2026-06-22T01:56:39.86242Z","steps":["trace[1705851065] 'count revisions from in-memory index tree' (duration: 317.388005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:39.862496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:56:39.544766Z","time spent":"317.714012ms","remote":"127.0.0.1:53780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-22T01:56:39.862484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.479014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4867"} {"level":"info","ts":"2026-06-22T01:56:39.86264Z","caller":"traceutil/trace.go:171","msg":"trace[21555509] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4639; }","duration":"354.68944ms","start":"2026-06-22T01:56:39.507921Z","end":"2026-06-22T01:56:39.862611Z","steps":["trace[21555509] 'range keys from in-memory index tree' (duration: 354.181598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:39.862704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:56:39.507908Z","time spent":"354.782202ms","remote":"127.0.0.1:42000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":4890,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" "} {"level":"info","ts":"2026-06-22T01:56:49.308383Z","caller":"traceutil/trace.go:171","msg":"trace[1469596428] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"119.4948ms","start":"2026-06-22T01:56:49.188861Z","end":"2026-06-22T01:56:49.308355Z","steps":["trace[1469596428] 'process raft request' (duration: 119.243835ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:49.554374Z","caller":"traceutil/trace.go:171","msg":"trace[1204659460] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"186.064832ms","start":"2026-06-22T01:56:49.368284Z","end":"2026-06-22T01:56:49.554349Z","steps":["trace[1204659460] 'process raft request' (duration: 185.739995ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:49.55467Z","caller":"traceutil/trace.go:171","msg":"trace[1924248117] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"186.320517ms","start":"2026-06-22T01:56:49.368328Z","end":"2026-06-22T01:56:49.554648Z","steps":["trace[1924248117] 'process raft request' (duration: 185.96762ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:49.554932Z","caller":"traceutil/trace.go:171","msg":"trace[1301604125] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"185.971999ms","start":"2026-06-22T01:56:49.368949Z","end":"2026-06-22T01:56:49.554921Z","steps":["trace[1301604125] 'process raft request' (duration: 185.549711ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:49.55495Z","caller":"traceutil/trace.go:171","msg":"trace[1821811736] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"184.799966ms","start":"2026-06-22T01:56:49.370117Z","end":"2026-06-22T01:56:49.554917Z","steps":["trace[1821811736] 'process raft request' (duration: 184.659933ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:56:49.575643Z","caller":"traceutil/trace.go:171","msg":"trace[1912570652] linearizableReadLoop","detail":"{readStateIndex:4960; appliedIndex:4955; }","duration":"162.648273ms","start":"2026-06-22T01:56:49.412974Z","end":"2026-06-22T01:56:49.575622Z","steps":["trace[1912570652] 'read index received' (duration: 140.98768ms)","trace[1912570652] 'applied index is now lower than readState.Index' (duration: 21.659713ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:56:49.575744Z","caller":"traceutil/trace.go:171","msg":"trace[628658393] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4755; }","duration":"190.630565ms","start":"2026-06-22T01:56:49.385071Z","end":"2026-06-22T01:56:49.575702Z","steps":["trace[628658393] 'process raft request' (duration: 190.473962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:49.57591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.924549ms","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-22T01:56:49.575955Z","caller":"traceutil/trace.go:171","msg":"trace[282063450] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4755; }","duration":"163.01643ms","start":"2026-06-22T01:56:49.412925Z","end":"2026-06-22T01:56:49.575942Z","steps":["trace[282063450] 'agreement among raft nodes before linearized reading' (duration: 162.829996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:56:49.576083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.777542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-22T01:56:49.576182Z","caller":"traceutil/trace.go:171","msg":"trace[101800697] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4755; }","duration":"154.924815ms","start":"2026-06-22T01:56:49.42124Z","end":"2026-06-22T01:56:49.576165Z","steps":["trace[101800697] 'agreement among raft nodes before linearized reading' (duration: 154.596368ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:57:29.633222Z","caller":"traceutil/trace.go:171","msg":"trace[1840590561] transaction","detail":"{read_only:false; response_revision:5151; number_of_response:1; }","duration":"105.281245ms","start":"2026-06-22T01:57:29.527911Z","end":"2026-06-22T01:57:29.633192Z","steps":["trace[1840590561] 'process raft request' (duration: 102.004313ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:59:48.628385Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3164} {"level":"info","ts":"2026-06-22T01:59:48.73902Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3164,"took":"109.344021ms","hash":2267453468,"current-db-size-bytes":59027456,"current-db-size":"59 MB","current-db-size-in-use-bytes":31272960,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-22T01:59:48.739077Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2267453468,"revision":3164,"compact-revision":-1} {"level":"warn","ts":"2026-06-22T02:00:50.79246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.386172ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T02:00:50.792563Z","caller":"traceutil/trace.go:171","msg":"trace[666481473] linearizableReadLoop","detail":"{readStateIndex:7149; appliedIndex:7148; }","duration":"235.801393ms","start":"2026-06-22T02:00:50.556745Z","end":"2026-06-22T02:00:50.792547Z","steps":["trace[666481473] 'read index received' (duration: 109.188966ms)","trace[666481473] 'applied index is now lower than readState.Index' (duration: 126.611147ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T02:00:50.792916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.277567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-22T02:00:50.792915Z","caller":"traceutil/trace.go:171","msg":"trace[2026142303] transaction","detail":"{read_only:false; response_revision:6838; number_of_response:1; }","duration":"256.727713ms","start":"2026-06-22T02:00:50.536159Z","end":"2026-06-22T02:00:50.792887Z","steps":["trace[2026142303] 'process raft request' (duration: 129.823278ms)","trace[2026142303] 'compare' (duration: 125.930881ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T02:00:50.792962Z","caller":"traceutil/trace.go:171","msg":"trace[568442981] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6838; }","duration":"152.33708ms","start":"2026-06-22T02:00:50.640616Z","end":"2026-06-22T02:00:50.792953Z","steps":["trace[568442981] 'agreement among raft nodes before linearized reading' (duration: 152.207685ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T02:00:50.792938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.162442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11500"} {"level":"info","ts":"2026-06-22T02:00:50.793025Z","caller":"traceutil/trace.go:171","msg":"trace[1768712534] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6838; }","duration":"236.268646ms","start":"2026-06-22T02:00:50.55674Z","end":"2026-06-22T02:00:50.793008Z","steps":["trace[1768712534] 'agreement among raft nodes before linearized reading' (duration: 235.988918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T02:00:50.793187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.19433ms","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-22T02:00:50.793207Z","caller":"traceutil/trace.go:171","msg":"trace[328041457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6838; }","duration":"149.237472ms","start":"2026-06-22T02:00:50.643965Z","end":"2026-06-22T02:00:50.793202Z","steps":["trace[328041457] 'agreement among raft nodes before linearized reading' (duration: 149.195671ms)"],"step_count":1}