{"level":"warn","ts":"2026-07-14T22:50:01.459536Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-14T22:50:01.459671Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-07-14T22:50:01.459764Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-14T22:50:01.459834Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-07-14T22:50:01.459876Z","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-07-14T22:50:01.46132Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-07-14T22:50:01.461473Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-07-14T22:50:01.465896Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.002566ms"} {"level":"info","ts":"2026-07-14T22:50:01.472495Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-07-14T22:50:01.472599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-07-14T22:50:01.472636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-07-14T22:50:01.472656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-14T22:50:01.472673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-07-14T22:50:01.472722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-07-14T22:50:01.480212Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-14T22:50:01.481716Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-14T22:50:01.482488Z","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-07-14T22:50:01.484611Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-14T22:50:01.484875Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-14T22:50:01.48492Z","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-07-14T22:50:01.485181Z","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-07-14T22:50:01.485206Z","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-07-14T22:50:01.487037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-07-14T22:50:01.487335Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-07-14T22:50:01.490321Z","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-07-14T22:50:01.490716Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-14T22:50:01.490755Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-14T22:50:01.491004Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-07-14T22:50:01.491031Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-07-14T22:50:02.073193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-07-14T22:50:02.073249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-14T22:50:02.073289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-07-14T22:50:02.073313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-07-14T22:50:02.073329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-07-14T22:50:02.07335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-07-14T22:50:02.073371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-07-14T22:50:02.074302Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:50:02.07606Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:50:02.076145Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:50:02.076214Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T22:50:02.07628Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-07-14T22:50:02.076554Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T22:50:02.076943Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T22:50:02.080003Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-07-14T22:50:02.080265Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-14T22:50:02.081007Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-14T22:50:02.081071Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-07-14T22:50:05.763815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.539279ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-14T22:50:05.763897Z","caller":"traceutil/trace.go:171","msg":"trace[544274243] linearizableReadLoop","detail":"{readStateIndex:206; appliedIndex:205; }","duration":"169.199664ms","start":"2026-07-14T22:50:05.594686Z","end":"2026-07-14T22:50:05.763886Z","steps":["trace[544274243] 'read index received' (duration: 41.52µs)","trace[544274243] 'applied index is now lower than readState.Index' (duration: 169.155904ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:50:05.763986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.301204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:50:05.764009Z","caller":"traceutil/trace.go:171","msg":"trace[1528059959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:201; }","duration":"169.370294ms","start":"2026-07-14T22:50:05.594631Z","end":"2026-07-14T22:50:05.764001Z","steps":["trace[1528059959] 'agreement among raft nodes before linearized reading' (duration: 169.289094ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:50:05.764068Z","caller":"traceutil/trace.go:171","msg":"trace[719104656] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"427.035307ms","start":"2026-07-14T22:50:05.336985Z","end":"2026-07-14T22:50:05.76402Z","steps":["trace[719104656] 'process raft request' (duration: 242.965728ms)","trace[719104656] 'compare' (duration: 183.428049ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:50:05.764171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:50:05.336965Z","time spent":"427.162887ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1342,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T22:50:05.922482Z","caller":"traceutil/trace.go:171","msg":"trace[801620743] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"132.068733ms","start":"2026-07-14T22:50:05.790392Z","end":"2026-07-14T22:50:05.92246Z","steps":["trace[801620743] 'process raft request' (duration: 132.028673ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:50:05.922517Z","caller":"traceutil/trace.go:171","msg":"trace[1465732905] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"153.63003ms","start":"2026-07-14T22:50:05.768846Z","end":"2026-07-14T22:50:05.922476Z","steps":["trace[1465732905] 'process raft request' (duration: 134.37483ms)","trace[1465732905] 'compare' (duration: 19.07799ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:50:44.884372Z","caller":"traceutil/trace.go:171","msg":"trace[1878268999] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"353.592345ms","start":"2026-07-14T22:50:44.53076Z","end":"2026-07-14T22:50:44.884352Z","steps":["trace[1878268999] 'read index received' (duration: 352.858136ms)","trace[1878268999] 'applied index is now lower than readState.Index' (duration: 733.589µs)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:50:44.884492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.715355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9hzxj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-14T22:50:44.884481Z","caller":"traceutil/trace.go:171","msg":"trace[1307900021] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"356.617803ms","start":"2026-07-14T22:50:44.527835Z","end":"2026-07-14T22:50:44.884452Z","steps":["trace[1307900021] 'process raft request' (duration: 356.045484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:50:44.884545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.644465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T22:50:44.88456Z","caller":"traceutil/trace.go:171","msg":"trace[1882566747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"276.703965ms","start":"2026-07-14T22:50:44.607851Z","end":"2026-07-14T22:50:44.884555Z","steps":["trace[1882566747] 'agreement among raft nodes before linearized reading' (duration: 276.681535ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:50:44.884516Z","caller":"traceutil/trace.go:171","msg":"trace[842191952] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9hzxj; range_end:; response_count:1; response_revision:594; }","duration":"353.787585ms","start":"2026-07-14T22:50:44.530721Z","end":"2026-07-14T22:50:44.884509Z","steps":["trace[842191952] 'agreement among raft nodes before linearized reading' (duration: 353.721365ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:50:44.884843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:50:44.527788Z","time spent":"356.762233ms","remote":"127.0.0.1:54084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T22:50:44.884928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T22:50:44.530705Z","time spent":"354.211245ms","remote":"127.0.0.1:54180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-9hzxj\" "} {"level":"info","ts":"2026-07-14T22:51:28.188477Z","caller":"traceutil/trace.go:171","msg":"trace[1319004173] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"202.965194ms","start":"2026-07-14T22:51:27.985463Z","end":"2026-07-14T22:51:28.188428Z","steps":["trace[1319004173] 'process raft request' (duration: 202.729075ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:52:12.192684Z","caller":"traceutil/trace.go:171","msg":"trace[1775820917] linearizableReadLoop","detail":"{readStateIndex:1867; appliedIndex:1866; }","duration":"235.394025ms","start":"2026-07-14T22:52:11.957268Z","end":"2026-07-14T22:52:12.192662Z","steps":["trace[1775820917] 'read index received' (duration: 235.229372ms)","trace[1775820917] 'applied index is now lower than readState.Index' (duration: 163.723µs)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:52:12.192955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.576764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-49313380-282e-42e4-9464-c636ce6265f1\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-14T22:52:12.192889Z","caller":"traceutil/trace.go:171","msg":"trace[389284887] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"262.297329ms","start":"2026-07-14T22:52:11.930547Z","end":"2026-07-14T22:52:12.192844Z","steps":["trace[389284887] 'process raft request' (duration: 262.005153ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:52:12.193024Z","caller":"traceutil/trace.go:171","msg":"trace[199424080] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-49313380-282e-42e4-9464-c636ce6265f1; range_end:; response_count:1; response_revision:1798; }","duration":"223.669795ms","start":"2026-07-14T22:52:11.969327Z","end":"2026-07-14T22:52:12.192997Z","steps":["trace[199424080] 'agreement among raft nodes before linearized reading' (duration: 223.460151ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:52:12.193303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.027619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18c249c9151f816c\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-07-14T22:52:12.193357Z","caller":"traceutil/trace.go:171","msg":"trace[1559852155] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18c249c9151f816c; range_end:; response_count:1; response_revision:1798; }","duration":"236.127961ms","start":"2026-07-14T22:52:11.957214Z","end":"2026-07-14T22:52:12.193342Z","steps":["trace[1559852155] 'agreement among raft nodes before linearized reading' (duration: 235.930717ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:52:46.047992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.626739ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T22:52:46.048196Z","caller":"traceutil/trace.go:171","msg":"trace[468170053] linearizableReadLoop","detail":"{readStateIndex:2116; appliedIndex:2115; }","duration":"144.358622ms","start":"2026-07-14T22:52:45.90382Z","end":"2026-07-14T22:52:46.048179Z","steps":["trace[468170053] 'read index received' (duration: 4.429729ms)","trace[468170053] 'applied index is now lower than readState.Index' (duration: 139.927853ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:52:46.048293Z","caller":"traceutil/trace.go:171","msg":"trace[908289897] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"162.716379ms","start":"2026-07-14T22:52:45.885565Z","end":"2026-07-14T22:52:46.048282Z","steps":["trace[908289897] 'process raft request' (duration: 22.704324ms)","trace[908289897] 'compare' (duration: 139.396195ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:52:46.048439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.600816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T22:52:46.048495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.752591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-14T22:52:46.048577Z","caller":"traceutil/trace.go:171","msg":"trace[1732902476] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2041; }","duration":"139.864282ms","start":"2026-07-14T22:52:45.908695Z","end":"2026-07-14T22:52:46.04856Z","steps":["trace[1732902476] 'agreement among raft nodes before linearized reading' (duration: 139.678179ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:52:46.048549Z","caller":"traceutil/trace.go:171","msg":"trace[1123569006] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:2041; }","duration":"144.764279ms","start":"2026-07-14T22:52:45.903764Z","end":"2026-07-14T22:52:46.048529Z","steps":["trace[1123569006] 'agreement among raft nodes before linearized reading' (duration: 144.553035ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:52:46.886421Z","caller":"traceutil/trace.go:171","msg":"trace[1310204964] linearizableReadLoop","detail":"{readStateIndex:2119; appliedIndex:2118; }","duration":"162.537408ms","start":"2026-07-14T22:52:46.723859Z","end":"2026-07-14T22:52:46.886396Z","steps":["trace[1310204964] 'read index received' (duration: 162.364816ms)","trace[1310204964] 'applied index is now lower than readState.Index' (duration: 170.922µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:52:46.886454Z","caller":"traceutil/trace.go:171","msg":"trace[418413788] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"183.590984ms","start":"2026-07-14T22:52:46.70283Z","end":"2026-07-14T22:52:46.886421Z","steps":["trace[418413788] 'process raft request' (duration: 183.406491ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:52:46.886762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.887714ms","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-07-14T22:52:46.886854Z","caller":"traceutil/trace.go:171","msg":"trace[675857202] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2043; }","duration":"163.038666ms","start":"2026-07-14T22:52:46.723796Z","end":"2026-07-14T22:52:46.886834Z","steps":["trace[675857202] 'agreement among raft nodes before linearized reading' (duration: 162.732631ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:52:46.967866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.045789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-14T22:52:46.967947Z","caller":"traceutil/trace.go:171","msg":"trace[1059005567] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2045; }","duration":"147.170432ms","start":"2026-07-14T22:52:46.820759Z","end":"2026-07-14T22:52:46.967929Z","steps":["trace[1059005567] 'agreement among raft nodes before linearized reading' (duration: 146.890938ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:52:46.96795Z","caller":"traceutil/trace.go:171","msg":"trace[1430270811] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"229.925429ms","start":"2026-07-14T22:52:46.737983Z","end":"2026-07-14T22:52:46.967908Z","steps":["trace[1430270811] 'process raft request' (duration: 200.256511ms)","trace[1430270811] 'compare' (duration: 29.17055ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T22:52:46.968158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.75686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-14T22:52:46.968243Z","caller":"traceutil/trace.go:171","msg":"trace[1220642126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2045; }","duration":"145.861682ms","start":"2026-07-14T22:52:46.822365Z","end":"2026-07-14T22:52:46.968227Z","steps":["trace[1220642126] 'agreement among raft nodes before linearized reading' (duration: 145.684269ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:52:47.163935Z","caller":"traceutil/trace.go:171","msg":"trace[755899083] linearizableReadLoop","detail":"{readStateIndex:2123; appliedIndex:2121; }","duration":"156.405132ms","start":"2026-07-14T22:52:47.007513Z","end":"2026-07-14T22:52:47.163918Z","steps":["trace[755899083] 'read index received' (duration: 100.861743ms)","trace[755899083] 'applied index is now lower than readState.Index' (duration: 55.542709ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:52:47.164247Z","caller":"traceutil/trace.go:171","msg":"trace[915673233] transaction","detail":"{read_only:false; response_revision:2046; number_of_response:1; }","duration":"192.986196ms","start":"2026-07-14T22:52:46.971252Z","end":"2026-07-14T22:52:47.164238Z","steps":["trace[915673233] 'process raft request' (duration: 137.108132ms)","trace[915673233] 'compare' (duration: 55.424067ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T22:52:47.164408Z","caller":"traceutil/trace.go:171","msg":"trace[791856473] transaction","detail":"{read_only:false; response_revision:2047; number_of_response:1; }","duration":"191.753577ms","start":"2026-07-14T22:52:46.972628Z","end":"2026-07-14T22:52:47.164382Z","steps":["trace[791856473] 'process raft request' (duration: 191.258959ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:52:47.164593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.071252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-14T22:52:47.164809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.20008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-14T22:52:47.164868Z","caller":"traceutil/trace.go:171","msg":"trace[1487352358] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2047; }","duration":"109.288312ms","start":"2026-07-14T22:52:47.055565Z","end":"2026-07-14T22:52:47.164853Z","steps":["trace[1487352358] 'agreement among raft nodes before linearized reading' (duration: 108.979847ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:52:47.164832Z","caller":"traceutil/trace.go:171","msg":"trace[1442494371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2047; }","duration":"157.338366ms","start":"2026-07-14T22:52:47.007471Z","end":"2026-07-14T22:52:47.164809Z","steps":["trace[1442494371] 'agreement among raft nodes before linearized reading' (duration: 156.993841ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:54:24.700037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.773275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-07-14T22:54:24.700111Z","caller":"traceutil/trace.go:171","msg":"trace[562108965] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2673; }","duration":"214.854666ms","start":"2026-07-14T22:54:24.485239Z","end":"2026-07-14T22:54:24.700094Z","steps":["trace[562108965] 'range keys from in-memory index tree' (duration: 214.645384ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T22:58:25.196447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.573103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-07-14T22:58:25.196532Z","caller":"traceutil/trace.go:171","msg":"trace[1488041235] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4824; }","duration":"105.728726ms","start":"2026-07-14T22:58:25.090782Z","end":"2026-07-14T22:58:25.196511Z","steps":["trace[1488041235] 'range keys from in-memory index tree' (duration: 105.250926ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T22:59:01.553048Z","caller":"traceutil/trace.go:171","msg":"trace[798797386] transaction","detail":"{read_only:false; response_revision:5150; number_of_response:1; }","duration":"102.937815ms","start":"2026-07-14T22:59:01.450091Z","end":"2026-07-14T22:59:01.553029Z","steps":["trace[798797386] 'process raft request' (duration: 73.902463ms)","trace[798797386] 'compare' (duration: 28.418761ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:00:02.223142Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2872} {"level":"info","ts":"2026-07-14T23:00:02.298872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2872,"took":"74.14393ms","hash":705159292,"current-db-size-bytes":53796864,"current-db-size":"54 MB","current-db-size-in-use-bytes":29933568,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-14T23:00:02.298966Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":705159292,"revision":2872,"compact-revision":-1} {"level":"warn","ts":"2026-07-14T23:00:18.81614Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656054032378344693,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T23:00:19.316575Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656054032378344693,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T23:00:19.816695Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656054032378344693,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T23:00:19.871319Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.909869488s","expected-duration":"1s"} {"level":"info","ts":"2026-07-14T23:00:19.87308Z","caller":"traceutil/trace.go:171","msg":"trace[1225111218] transaction","detail":"{read_only:false; response_revision:5673; number_of_response:1; }","duration":"1.912196091s","start":"2026-07-14T23:00:17.960866Z","end":"2026-07-14T23:00:19.873063Z","steps":["trace[1225111218] 'process raft request' (duration: 1.91211257s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.873177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:17.960798Z","time spent":"1.912316523s","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:19.873552Z","caller":"traceutil/trace.go:171","msg":"trace[1421666316] transaction","detail":"{read_only:false; response_revision:5674; number_of_response:1; }","duration":"1.909724156s","start":"2026-07-14T23:00:17.963796Z","end":"2026-07-14T23:00:19.87352Z","steps":["trace[1421666316] 'process raft request' (duration: 1.909244019s)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:19.873862Z","caller":"traceutil/trace.go:171","msg":"trace[2020838057] transaction","detail":"{read_only:false; response_revision:5672; number_of_response:1; }","duration":"1.913029474s","start":"2026-07-14T23:00:17.960821Z","end":"2026-07-14T23:00:19.87385Z","steps":["trace[2020838057] 'process raft request' (duration: 1.91069033s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.874744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:17.960796Z","time spent":"1.913884935s","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:19.874112Z","caller":"traceutil/trace.go:171","msg":"trace[1665469756] linearizableReadLoop","detail":"{readStateIndex:5879; appliedIndex:5875; }","duration":"1.558357072s","start":"2026-07-14T23:00:18.315731Z","end":"2026-07-14T23:00:19.874088Z","steps":["trace[1665469756] 'read index received' (duration: 1.555781575s)","trace[1665469756] 'applied index is now lower than readState.Index' (duration: 2.574627ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:00:19.874854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:17.963786Z","time spent":"1.910792341s","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:00:19.874135Z","caller":"traceutil/trace.go:171","msg":"trace[1051708387] transaction","detail":"{read_only:false; response_revision:5675; number_of_response:1; }","duration":"1.842955272s","start":"2026-07-14T23:00:18.031171Z","end":"2026-07-14T23:00:19.874127Z","steps":["trace[1051708387] 'process raft request' (duration: 1.842264623s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.874205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.558453983s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:19.875144Z","caller":"traceutil/trace.go:171","msg":"trace[2011683871] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5675; }","duration":"1.559444047s","start":"2026-07-14T23:00:18.315688Z","end":"2026-07-14T23:00:19.875132Z","steps":["trace[2011683871] 'agreement among raft nodes before linearized reading' (duration: 1.558467293s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.875172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:18.315667Z","time spent":"1.559497768s","remote":"127.0.0.1:54220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-07-14T23:00:19.875361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.395426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-14T23:00:19.875392Z","caller":"traceutil/trace.go:171","msg":"trace[493197306] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5675; }","duration":"481.462847ms","start":"2026-07-14T23:00:19.393922Z","end":"2026-07-14T23:00:19.875385Z","steps":["trace[493197306] 'agreement among raft nodes before linearized reading' (duration: 481.353876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.875397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.598882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-14T23:00:19.875412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:19.393901Z","time spent":"481.505998ms","remote":"127.0.0.1:54180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-07-14T23:00:19.875424Z","caller":"traceutil/trace.go:171","msg":"trace[482949488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5675; }","duration":"880.668144ms","start":"2026-07-14T23:00:18.994745Z","end":"2026-07-14T23:00:19.875414Z","steps":["trace[482949488] 'agreement among raft nodes before linearized reading' (duration: 880.630753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.875435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.097825ms","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-07-14T23:00:19.875467Z","caller":"traceutil/trace.go:171","msg":"trace[306916066] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5675; }","duration":"814.154605ms","start":"2026-07-14T23:00:19.061305Z","end":"2026-07-14T23:00:19.87546Z","steps":["trace[306916066] 'agreement among raft nodes before linearized reading' (duration: 814.058374ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.87549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:19.061178Z","time spent":"814.307378ms","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-14T23:00:19.875559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.055787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T23:00:19.875576Z","caller":"traceutil/trace.go:171","msg":"trace[1224362174] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:5675; }","duration":"560.104197ms","start":"2026-07-14T23:00:19.315468Z","end":"2026-07-14T23:00:19.875572Z","steps":["trace[1224362174] 'agreement among raft nodes before linearized reading' (duration: 560.069076ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.875591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:19.315451Z","time spent":"560.135978ms","remote":"127.0.0.1:54230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":6,"response size":30,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-07-14T23:00:19.875622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.303746049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"warn","ts":"2026-07-14T23:00:19.875346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.555039504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:672"} {"level":"info","ts":"2026-07-14T23:00:19.875662Z","caller":"traceutil/trace.go:171","msg":"trace[34528061] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5675; }","duration":"1.30383722s","start":"2026-07-14T23:00:18.571816Z","end":"2026-07-14T23:00:19.875653Z","steps":["trace[34528061] 'agreement among raft nodes before linearized reading' (duration: 1.303774539s)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:00:19.875678Z","caller":"traceutil/trace.go:171","msg":"trace[400116170] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:5675; }","duration":"1.555404929s","start":"2026-07-14T23:00:18.320267Z","end":"2026-07-14T23:00:19.875672Z","steps":["trace[400116170] 'agreement among raft nodes before linearized reading' (duration: 1.55477365s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.875687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:18.571787Z","time spent":"1.303894111s","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":595,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-07-14T23:00:19.875702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:18.320261Z","time spent":"1.5554351s","remote":"127.0.0.1:54154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":695,"request content":"key:\"/registry/services/endpoints/openstack/keystone-api\" "} {"level":"warn","ts":"2026-07-14T23:00:19.875768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.641522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:19.875796Z","caller":"traceutil/trace.go:171","msg":"trace[1315850030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5675; }","duration":"267.689652ms","start":"2026-07-14T23:00:19.608099Z","end":"2026-07-14T23:00:19.875789Z","steps":["trace[1315850030] 'agreement among raft nodes before linearized reading' (duration: 267.649401ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.87509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:18.031151Z","time spent":"1.843909766s","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:00:19.875456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:18.994719Z","time spent":"880.728724ms","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-14T23:00:19.876889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.204822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:00:19.876944Z","caller":"traceutil/trace.go:171","msg":"trace[308526249] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:5675; }","duration":"330.307864ms","start":"2026-07-14T23:00:19.546623Z","end":"2026-07-14T23:00:19.876931Z","steps":["trace[308526249] 'agreement among raft nodes before linearized reading' (duration: 328.978175ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:00:19.877022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:00:19.546587Z","time spent":"330.423245ms","remote":"127.0.0.1:53506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"info","ts":"2026-07-14T23:01:48.413172Z","caller":"traceutil/trace.go:171","msg":"trace[343626305] transaction","detail":"{read_only:false; response_revision:6317; number_of_response:1; }","duration":"121.437604ms","start":"2026-07-14T23:01:48.291682Z","end":"2026-07-14T23:01:48.413119Z","steps":["trace[343626305] 'process raft request' (duration: 121.252222ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:02:16.709077Z","caller":"traceutil/trace.go:171","msg":"trace[68697577] transaction","detail":"{read_only:false; response_revision:6524; number_of_response:1; }","duration":"107.531615ms","start":"2026-07-14T23:02:16.601361Z","end":"2026-07-14T23:02:16.708892Z","steps":["trace[68697577] 'process raft request' (duration: 107.362213ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:02:16.716861Z","caller":"traceutil/trace.go:171","msg":"trace[641033753] linearizableReadLoop","detail":"{readStateIndex:6764; appliedIndex:6760; }","duration":"110.984017ms","start":"2026-07-14T23:02:16.605865Z","end":"2026-07-14T23:02:16.716849Z","steps":["trace[641033753] 'read index received' (duration: 102.928048ms)","trace[641033753] 'applied index is now lower than readState.Index' (duration: 8.054969ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:02:16.717009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.13405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:02:16.717059Z","caller":"traceutil/trace.go:171","msg":"trace[1504627724] transaction","detail":"{read_only:false; response_revision:6527; number_of_response:1; }","duration":"113.840242ms","start":"2026-07-14T23:02:16.60321Z","end":"2026-07-14T23:02:16.71705Z","steps":["trace[1504627724] 'process raft request' (duration: 113.61025ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:02:16.717103Z","caller":"traceutil/trace.go:171","msg":"trace[493194948] transaction","detail":"{read_only:false; response_revision:6526; number_of_response:1; }","duration":"114.307948ms","start":"2026-07-14T23:02:16.602744Z","end":"2026-07-14T23:02:16.717052Z","steps":["trace[493194948] 'process raft request' (duration: 113.990435ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:02:16.717099Z","caller":"traceutil/trace.go:171","msg":"trace[238053117] transaction","detail":"{read_only:false; response_revision:6525; number_of_response:1; }","duration":"115.27328ms","start":"2026-07-14T23:02:16.601754Z","end":"2026-07-14T23:02:16.717027Z","steps":["trace[238053117] 'process raft request' (duration: 114.910786ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:02:16.717489Z","caller":"traceutil/trace.go:171","msg":"trace[1194636637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6527; }","duration":"111.21989ms","start":"2026-07-14T23:02:16.605805Z","end":"2026-07-14T23:02:16.717025Z","steps":["trace[1194636637] 'agreement among raft nodes before linearized reading' (duration: 111.084118ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:05:02.232672Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5594} {"level":"info","ts":"2026-07-14T23:05:02.304892Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5594,"took":"70.991572ms","hash":3778893739,"current-db-size-bytes":53796864,"current-db-size":"54 MB","current-db-size-in-use-bytes":18251776,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-14T23:05:02.304937Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3778893739,"revision":5594,"compact-revision":2872}