{"level":"warn","ts":"2026-07-26T17:21:45.21317Z","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-26T17:21:45.213261Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-26T17:21:45.213327Z","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-26T17:21:45.213336Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-07-26T17:21:45.213362Z","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-26T17:21:45.214156Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-07-26T17:21:45.21423Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-26T17:21:45.218089Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.677461ms"} {"level":"info","ts":"2026-07-26T17:21:45.233303Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-07-26T17:21:45.233424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-07-26T17:21:45.233469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-07-26T17:21:45.233485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-26T17:21:45.23351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-07-26T17:21:45.233565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-07-26T17:21:45.23907Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-26T17:21:45.240578Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-26T17:21:45.242385Z","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-26T17:21:45.244533Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-26T17:21:45.245881Z","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-26T17:21:45.24585Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-26T17:21:45.245968Z","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-26T17:21:45.246052Z","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-26T17:21:45.247767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-07-26T17:21:45.248167Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-07-26T17:21:45.250148Z","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-26T17:21:45.250434Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-26T17:21:45.25048Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-26T17:21:45.250532Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-07-26T17:21:45.250567Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-07-26T17:21:46.034183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-07-26T17:21:46.034267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-07-26T17:21:46.0343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-07-26T17:21:46.034316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-07-26T17:21:46.034324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-07-26T17:21:46.034336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-07-26T17:21:46.034346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-07-26T17:21:46.035656Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-07-26T17:21:46.035709Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-26T17:21:46.035878Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-26T17:21:46.036074Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T17:21:46.036401Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-26T17:21:46.036427Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-26T17:21:46.03747Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T17:21:46.037597Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T17:21:46.037652Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T17:21:46.038084Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-07-26T17:21:46.04005Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-26T17:22:02.026749Z","caller":"traceutil/trace.go:171","msg":"trace[184422302] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"135.357842ms","start":"2026-07-26T17:22:01.891359Z","end":"2026-07-26T17:22:02.026717Z","steps":["trace[184422302] 'process raft request' (duration: 135.209939ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:22:25.947683Z","caller":"traceutil/trace.go:171","msg":"trace[596944325] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"104.375993ms","start":"2026-07-26T17:22:25.843273Z","end":"2026-07-26T17:22:25.947649Z","steps":["trace[596944325] 'process raft request' (duration: 104.106319ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:22:32.08102Z","caller":"traceutil/trace.go:171","msg":"trace[917797398] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"118.644977ms","start":"2026-07-26T17:22:31.962337Z","end":"2026-07-26T17:22:32.080982Z","steps":["trace[917797398] 'process raft request' (duration: 117.964025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:22:32.535971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.749467ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-26T17:22:32.536133Z","caller":"traceutil/trace.go:171","msg":"trace[376162010] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"355.583187ms","start":"2026-07-26T17:22:32.180532Z","end":"2026-07-26T17:22:32.536115Z","steps":["trace[376162010] 'read index received' (duration: 183.115479ms)","trace[376162010] 'applied index is now lower than readState.Index' (duration: 172.466428ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:22:32.536215Z","caller":"traceutil/trace.go:171","msg":"trace[1172720120] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"399.608128ms","start":"2026-07-26T17:22:32.136522Z","end":"2026-07-26T17:22:32.53613Z","steps":["trace[1172720120] 'process raft request' (duration: 227.153421ms)","trace[1172720120] 'compare' (duration: 171.609924ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T17:22:32.536384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.847211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-26T17:22:32.536425Z","caller":"traceutil/trace.go:171","msg":"trace[1459581404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:596; }","duration":"355.926983ms","start":"2026-07-26T17:22:32.180487Z","end":"2026-07-26T17:22:32.536414Z","steps":["trace[1459581404] 'agreement among raft nodes before linearized reading' (duration: 355.75955ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:22:32.536461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T17:22:32.180464Z","time spent":"355.987533ms","remote":"127.0.0.1:45984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-26T17:22:32.536444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T17:22:32.136496Z","time spent":"399.833011ms","remote":"127.0.0.1:46238","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-07-26T17:22:32.536717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.840225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wbtlq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-26T17:22:32.536755Z","caller":"traceutil/trace.go:171","msg":"trace[1389960510] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wbtlq; range_end:; response_count:1; response_revision:596; }","duration":"265.898057ms","start":"2026-07-26T17:22:32.270848Z","end":"2026-07-26T17:22:32.536746Z","steps":["trace[1389960510] 'agreement among raft nodes before linearized reading' (duration: 265.830506ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:22:32.536802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.860958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-26T17:22:32.536905Z","caller":"traceutil/trace.go:171","msg":"trace[1544722828] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:596; }","duration":"278.00515ms","start":"2026-07-26T17:22:32.258875Z","end":"2026-07-26T17:22:32.53688Z","steps":["trace[1544722828] 'agreement among raft nodes before linearized reading' (duration: 277.722156ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:22:32.536878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.927199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-26T17:22:32.536985Z","caller":"traceutil/trace.go:171","msg":"trace[1462911948] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:596; }","duration":"241.111932ms","start":"2026-07-26T17:22:32.295846Z","end":"2026-07-26T17:22:32.536958Z","steps":["trace[1462911948] 'agreement among raft nodes before linearized reading' (duration: 240.802807ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:23:44.820193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.138989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T17:23:44.820301Z","caller":"traceutil/trace.go:171","msg":"trace[633573970] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1748; }","duration":"110.317471ms","start":"2026-07-26T17:23:44.709961Z","end":"2026-07-26T17:23:44.820279Z","steps":["trace[633573970] 'count revisions from in-memory index tree' (duration: 110.014108ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:23:44.996176Z","caller":"traceutil/trace.go:171","msg":"trace[590129480] transaction","detail":"{read_only:false; response_revision:1750; number_of_response:1; }","duration":"208.88018ms","start":"2026-07-26T17:23:44.78724Z","end":"2026-07-26T17:23:44.99612Z","steps":["trace[590129480] 'process raft request' (duration: 140.469373ms)","trace[590129480] 'compare' (duration: 68.145575ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:23:44.996524Z","caller":"traceutil/trace.go:171","msg":"trace[97900378] transaction","detail":"{read_only:false; response_revision:1752; number_of_response:1; }","duration":"106.619602ms","start":"2026-07-26T17:23:44.889886Z","end":"2026-07-26T17:23:44.996505Z","steps":["trace[97900378] 'process raft request' (duration: 106.463761ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:23:44.996503Z","caller":"traceutil/trace.go:171","msg":"trace[1273850038] transaction","detail":"{read_only:false; response_revision:1751; number_of_response:1; }","duration":"163.936084ms","start":"2026-07-26T17:23:44.832523Z","end":"2026-07-26T17:23:44.996459Z","steps":["trace[1273850038] 'process raft request' (duration: 163.508691ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:23:45.267933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.694225ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T17:23:45.268147Z","caller":"traceutil/trace.go:171","msg":"trace[1147888360] linearizableReadLoop","detail":"{readStateIndex:1822; appliedIndex:1820; }","duration":"127.605043ms","start":"2026-07-26T17:23:45.140521Z","end":"2026-07-26T17:23:45.268126Z","steps":["trace[1147888360] 'read index received' (duration: 53.82µs)","trace[1147888360] 'applied index is now lower than readState.Index' (duration: 127.549683ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:23:45.268236Z","caller":"traceutil/trace.go:171","msg":"trace[893198860] transaction","detail":"{read_only:false; response_revision:1755; number_of_response:1; }","duration":"266.602945ms","start":"2026-07-26T17:23:45.001576Z","end":"2026-07-26T17:23:45.268179Z","steps":["trace[893198860] 'process raft request' (duration: 266.470234ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:23:45.268387Z","caller":"traceutil/trace.go:171","msg":"trace[1494961383] transaction","detail":"{read_only:false; response_revision:1754; number_of_response:1; }","duration":"267.18852ms","start":"2026-07-26T17:23:45.000973Z","end":"2026-07-26T17:23:45.268161Z","steps":["trace[1494961383] 'process raft request' (duration: 103.996731ms)","trace[1494961383] 'compare' (duration: 162.333261ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T17:23:45.268513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.955257ms","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-07-26T17:23:45.26866Z","caller":"traceutil/trace.go:171","msg":"trace[1408724953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1755; }","duration":"128.164528ms","start":"2026-07-26T17:23:45.140472Z","end":"2026-07-26T17:23:45.268637Z","steps":["trace[1408724953] 'agreement among raft nodes before linearized reading' (duration: 127.831306ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:23:45.404223Z","caller":"traceutil/trace.go:171","msg":"trace[1070356055] transaction","detail":"{read_only:false; response_revision:1756; number_of_response:1; }","duration":"130.805748ms","start":"2026-07-26T17:23:45.273368Z","end":"2026-07-26T17:23:45.404174Z","steps":["trace[1070356055] 'process raft request' (duration: 101.917035ms)","trace[1070356055] 'compare' (duration: 28.676171ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:23:46.969967Z","caller":"traceutil/trace.go:171","msg":"trace[198762011] transaction","detail":"{read_only:false; response_revision:1759; number_of_response:1; }","duration":"126.977079ms","start":"2026-07-26T17:23:46.842967Z","end":"2026-07-26T17:23:46.969944Z","steps":["trace[198762011] 'process raft request' (duration: 126.809707ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:23:47.286145Z","caller":"traceutil/trace.go:171","msg":"trace[1336868670] transaction","detail":"{read_only:false; response_revision:1762; number_of_response:1; }","duration":"233.186557ms","start":"2026-07-26T17:23:47.052909Z","end":"2026-07-26T17:23:47.286095Z","steps":["trace[1336868670] 'process raft request' (duration: 232.991756ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:23:49.119127Z","caller":"traceutil/trace.go:171","msg":"trace[692905918] transaction","detail":"{read_only:false; response_revision:1772; number_of_response:1; }","duration":"143.224553ms","start":"2026-07-26T17:23:48.975868Z","end":"2026-07-26T17:23:49.119093Z","steps":["trace[692905918] 'process raft request' (duration: 63.850522ms)","trace[692905918] 'compare' (duration: 79.18439ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T17:24:19.53877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.630368ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T17:24:19.539349Z","caller":"traceutil/trace.go:171","msg":"trace[823346481] transaction","detail":"{read_only:false; response_revision:1951; number_of_response:1; }","duration":"284.14801ms","start":"2026-07-26T17:24:19.255167Z","end":"2026-07-26T17:24:19.539315Z","steps":["trace[823346481] 'process raft request' (duration: 131.840276ms)","trace[823346481] 'compare' (duration: 151.345766ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:24:19.539352Z","caller":"traceutil/trace.go:171","msg":"trace[1065458480] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"277.484958ms","start":"2026-07-26T17:24:19.261809Z","end":"2026-07-26T17:24:19.539294Z","steps":["trace[1065458480] 'process raft request' (duration: 277.149474ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:24:19.539346Z","caller":"traceutil/trace.go:171","msg":"trace[260649928] linearizableReadLoop","detail":"{readStateIndex:2026; appliedIndex:2024; }","duration":"212.205296ms","start":"2026-07-26T17:24:19.327099Z","end":"2026-07-26T17:24:19.539305Z","steps":["trace[260649928] 'read index received' (duration: 59.968372ms)","trace[260649928] 'applied index is now lower than readState.Index' (duration: 152.234214ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T17:24:19.539611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.686962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T17:24:19.539705Z","caller":"traceutil/trace.go:171","msg":"trace[1084577399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1952; }","duration":"285.881593ms","start":"2026-07-26T17:24:19.253804Z","end":"2026-07-26T17:24:19.539686Z","steps":["trace[1084577399] 'agreement among raft nodes before linearized reading' (duration: 285.612931ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:24:19.751944Z","caller":"traceutil/trace.go:171","msg":"trace[161022823] linearizableReadLoop","detail":"{readStateIndex:2028; appliedIndex:2027; }","duration":"210.403613ms","start":"2026-07-26T17:24:19.541516Z","end":"2026-07-26T17:24:19.75192Z","steps":["trace[161022823] 'read index received' (duration: 199.426428ms)","trace[161022823] 'applied index is now lower than readState.Index' (duration: 10.975805ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:24:19.751984Z","caller":"traceutil/trace.go:171","msg":"trace[1355276682] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"211.580081ms","start":"2026-07-26T17:24:19.540359Z","end":"2026-07-26T17:24:19.751939Z","steps":["trace[1355276682] 'process raft request' (duration: 200.486545ms)","trace[1355276682] 'compare' (duration: 10.881433ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T17:24:19.752302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.751425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T17:24:19.752383Z","caller":"traceutil/trace.go:171","msg":"trace[1463684724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1953; }","duration":"210.860856ms","start":"2026-07-26T17:24:19.541505Z","end":"2026-07-26T17:24:19.752366Z","steps":["trace[1463684724] 'agreement among raft nodes before linearized reading' (duration: 210.530443ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:24:19.802392Z","caller":"traceutil/trace.go:171","msg":"trace[401044522] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"257.711946ms","start":"2026-07-26T17:24:19.544621Z","end":"2026-07-26T17:24:19.802333Z","steps":["trace[401044522] 'process raft request' (duration: 257.389463ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:24:19.803577Z","caller":"traceutil/trace.go:171","msg":"trace[1281409254] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"258.851644ms","start":"2026-07-26T17:24:19.544703Z","end":"2026-07-26T17:24:19.803555Z","steps":["trace[1281409254] 'process raft request' (duration: 257.527923ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:24:19.803709Z","caller":"traceutil/trace.go:171","msg":"trace[2139816057] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"258.342731ms","start":"2026-07-26T17:24:19.545337Z","end":"2026-07-26T17:24:19.803679Z","steps":["trace[2139816057] 'process raft request' (duration: 258.13695ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:24:19.810601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.06789ms","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-26T17:24:19.810647Z","caller":"traceutil/trace.go:171","msg":"trace[6061091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1957; }","duration":"240.13998ms","start":"2026-07-26T17:24:19.570497Z","end":"2026-07-26T17:24:19.810637Z","steps":["trace[6061091] 'agreement among raft nodes before linearized reading' (duration: 239.981269ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:24:20.933355Z","caller":"traceutil/trace.go:171","msg":"trace[1169940965] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"143.117763ms","start":"2026-07-26T17:24:20.790203Z","end":"2026-07-26T17:24:20.933321Z","steps":["trace[1169940965] 'process raft request' (duration: 142.926081ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:25:42.726089Z","caller":"traceutil/trace.go:171","msg":"trace[405189295] transaction","detail":"{read_only:false; response_revision:2375; number_of_response:1; }","duration":"113.61361ms","start":"2026-07-26T17:25:42.612458Z","end":"2026-07-26T17:25:42.726071Z","steps":["trace[405189295] 'process raft request' (duration: 113.491978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:26:04.738626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.23386ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-26T17:26:04.738789Z","caller":"traceutil/trace.go:171","msg":"trace[1385950793] linearizableReadLoop","detail":"{readStateIndex:2581; appliedIndex:2580; }","duration":"197.315585ms","start":"2026-07-26T17:26:04.54145Z","end":"2026-07-26T17:26:04.738766Z","steps":["trace[1385950793] 'read index received' (duration: 82.821851ms)","trace[1385950793] 'applied index is now lower than readState.Index' (duration: 114.491934ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T17:26:04.73892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.459789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T17:26:04.738961Z","caller":"traceutil/trace.go:171","msg":"trace[1958325518] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2485; }","duration":"197.582711ms","start":"2026-07-26T17:26:04.541367Z","end":"2026-07-26T17:26:04.73895Z","steps":["trace[1958325518] 'agreement among raft nodes before linearized reading' (duration: 197.456218ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:31:33.442992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.708457ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T17:31:33.443384Z","caller":"traceutil/trace.go:171","msg":"trace[760071814] transaction","detail":"{read_only:false; response_revision:4428; number_of_response:1; }","duration":"185.085213ms","start":"2026-07-26T17:31:33.258274Z","end":"2026-07-26T17:31:33.443359Z","steps":["trace[760071814] 'process raft request' (duration: 184.90933ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:31:33.443448Z","caller":"traceutil/trace.go:171","msg":"trace[705179767] linearizableReadLoop","detail":"{readStateIndex:4602; appliedIndex:4601; }","duration":"199.481966ms","start":"2026-07-26T17:31:33.243892Z","end":"2026-07-26T17:31:33.443374Z","steps":["trace[705179767] 'read index received' (duration: 49.237356ms)","trace[705179767] 'applied index is now lower than readState.Index' (duration: 150.216569ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:31:33.443431Z","caller":"traceutil/trace.go:171","msg":"trace[1319459835] transaction","detail":"{read_only:false; response_revision:4427; number_of_response:1; }","duration":"221.615162ms","start":"2026-07-26T17:31:33.221746Z","end":"2026-07-26T17:31:33.443361Z","steps":["trace[1319459835] 'process raft request' (duration: 71.370033ms)","trace[1319459835] 'compare' (duration: 149.32966ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T17:31:33.443815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.008553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T17:31:33.443914Z","caller":"traceutil/trace.go:171","msg":"trace[792499075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4428; }","duration":"190.173917ms","start":"2026-07-26T17:31:33.253712Z","end":"2026-07-26T17:31:33.443886Z","steps":["trace[792499075] 'agreement among raft nodes before linearized reading' (duration: 189.973533ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:31:33.444147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.876573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-26T17:31:33.444334Z","caller":"traceutil/trace.go:171","msg":"trace[1220669495] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4428; }","duration":"200.467815ms","start":"2026-07-26T17:31:33.243817Z","end":"2026-07-26T17:31:33.444285Z","steps":["trace[1220669495] 'agreement among raft nodes before linearized reading' (duration: 199.589797ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:31:33.730531Z","caller":"traceutil/trace.go:171","msg":"trace[1972473475] linearizableReadLoop","detail":"{readStateIndex:4604; appliedIndex:4603; }","duration":"229.38333ms","start":"2026-07-26T17:31:33.501119Z","end":"2026-07-26T17:31:33.730503Z","steps":["trace[1972473475] 'read index received' (duration: 229.110044ms)","trace[1972473475] 'applied index is now lower than readState.Index' (duration: 272.066µs)"],"step_count":2} {"level":"warn","ts":"2026-07-26T17:31:33.730768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.634524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-59srg\" ","response":"range_response_count:1 size:20565"} {"level":"info","ts":"2026-07-26T17:31:33.730812Z","caller":"traceutil/trace.go:171","msg":"trace[634138693] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-59srg; range_end:; response_count:1; response_revision:4429; }","duration":"229.755107ms","start":"2026-07-26T17:31:33.501044Z","end":"2026-07-26T17:31:33.730799Z","steps":["trace[634138693] 'agreement among raft nodes before linearized reading' (duration: 229.579943ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:31:33.730782Z","caller":"traceutil/trace.go:171","msg":"trace[821254662] transaction","detail":"{read_only:false; response_revision:4429; number_of_response:1; }","duration":"248.153639ms","start":"2026-07-26T17:31:33.482417Z","end":"2026-07-26T17:31:33.73057Z","steps":["trace[821254662] 'process raft request' (duration: 247.881114ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:31:46.129802Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2692} {"level":"info","ts":"2026-07-26T17:31:46.200879Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2692,"took":"69.656369ms","hash":2014527377,"current-db-size-bytes":34803712,"current-db-size":"35 MB","current-db-size-in-use-bytes":9723904,"current-db-size-in-use":"9.7 MB"} {"level":"info","ts":"2026-07-26T17:31:46.200959Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2014527377,"revision":2692,"compact-revision":-1} {"level":"info","ts":"2026-07-26T17:32:28.741261Z","caller":"traceutil/trace.go:171","msg":"trace[1452283097] linearizableReadLoop","detail":"{readStateIndex:5023; appliedIndex:5022; }","duration":"170.595576ms","start":"2026-07-26T17:32:28.570615Z","end":"2026-07-26T17:32:28.741211Z","steps":["trace[1452283097] 'read index received' (duration: 170.132717ms)","trace[1452283097] 'applied index is now lower than readState.Index' (duration: 460.829µs)"],"step_count":2} {"level":"warn","ts":"2026-07-26T17:32:28.741734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.120171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-26T17:32:28.741815Z","caller":"traceutil/trace.go:171","msg":"trace[1896957996] transaction","detail":"{read_only:false; response_revision:4835; number_of_response:1; }","duration":"187.344422ms","start":"2026-07-26T17:32:28.554437Z","end":"2026-07-26T17:32:28.741782Z","steps":["trace[1896957996] 'process raft request' (duration: 186.370492ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:32:28.741842Z","caller":"traceutil/trace.go:171","msg":"trace[202813852] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:4835; }","duration":"132.285074ms","start":"2026-07-26T17:32:28.609537Z","end":"2026-07-26T17:32:28.741822Z","steps":["trace[202813852] 'agreement among raft nodes before linearized reading' (duration: 132.08316ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:32:28.742434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.811132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-07-26T17:32:28.742477Z","caller":"traceutil/trace.go:171","msg":"trace[1569896121] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4835; }","duration":"171.874783ms","start":"2026-07-26T17:32:28.570592Z","end":"2026-07-26T17:32:28.742466Z","steps":["trace[1569896121] 'agreement among raft nodes before linearized reading' (duration: 171.539767ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:32:39.530181Z","caller":"traceutil/trace.go:171","msg":"trace[1524933167] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"192.184623ms","start":"2026-07-26T17:32:39.337946Z","end":"2026-07-26T17:32:39.53013Z","steps":["trace[1524933167] 'process raft request' (duration: 169.296678ms)","trace[1524933167] 'compare' (duration: 22.688399ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:36:46.136376Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4494} {"level":"info","ts":"2026-07-26T17:36:46.176324Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4494,"took":"38.562832ms","hash":382983545,"current-db-size-bytes":34803712,"current-db-size":"35 MB","current-db-size-in-use-bytes":13094912,"current-db-size-in-use":"13 MB"} {"level":"info","ts":"2026-07-26T17:36:46.176393Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":382983545,"revision":4494,"compact-revision":2692} {"level":"info","ts":"2026-07-26T17:39:20.846653Z","caller":"traceutil/trace.go:171","msg":"trace[883099123] transaction","detail":"{read_only:false; response_revision:8030; number_of_response:1; }","duration":"140.81255ms","start":"2026-07-26T17:39:20.705811Z","end":"2026-07-26T17:39:20.846623Z","steps":["trace[883099123] 'process raft request' (duration: 140.759829ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:39:20.846903Z","caller":"traceutil/trace.go:171","msg":"trace[954569516] transaction","detail":"{read_only:false; response_revision:8029; number_of_response:1; }","duration":"151.42907ms","start":"2026-07-26T17:39:20.69546Z","end":"2026-07-26T17:39:20.846889Z","steps":["trace[954569516] 'process raft request' (duration: 151.071373ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:39:20.84664Z","caller":"traceutil/trace.go:171","msg":"trace[1915570948] transaction","detail":"{read_only:false; response_revision:8027; number_of_response:1; }","duration":"152.121444ms","start":"2026-07-26T17:39:20.694477Z","end":"2026-07-26T17:39:20.846598Z","steps":["trace[1915570948] 'process raft request' (duration: 144.731671ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:39:20.847172Z","caller":"traceutil/trace.go:171","msg":"trace[1582537292] transaction","detail":"{read_only:false; response_revision:8028; number_of_response:1; }","duration":"152.284138ms","start":"2026-07-26T17:39:20.694845Z","end":"2026-07-26T17:39:20.847129Z","steps":["trace[1582537292] 'process raft request' (duration: 151.645235ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:41:41.611789Z","caller":"traceutil/trace.go:171","msg":"trace[1993803615] transaction","detail":"{read_only:false; response_revision:9342; number_of_response:1; }","duration":"121.331777ms","start":"2026-07-26T17:41:41.490416Z","end":"2026-07-26T17:41:41.611748Z","steps":["trace[1993803615] 'process raft request' (duration: 121.166023ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:41:41.642688Z","caller":"traceutil/trace.go:171","msg":"trace[247432658] transaction","detail":"{read_only:false; response_revision:9343; number_of_response:1; }","duration":"150.757056ms","start":"2026-07-26T17:41:41.49191Z","end":"2026-07-26T17:41:41.642667Z","steps":["trace[247432658] 'process raft request' (duration: 132.063078ms)","trace[247432658] 'compare' (duration: 18.34694ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:41:46.142478Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6488} {"level":"info","ts":"2026-07-26T17:41:46.183579Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6488,"took":"39.739235ms","hash":3549052995,"current-db-size-bytes":34803712,"current-db-size":"35 MB","current-db-size-in-use-bytes":20504576,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-07-26T17:41:46.18365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3549052995,"revision":6488,"compact-revision":4494} {"level":"info","ts":"2026-07-26T17:42:02.680697Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1c917701ce165bac","local-member-applied-index":10008,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-26T17:42:02.697875Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10008} {"level":"info","ts":"2026-07-26T17:42:02.698018Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5008} {"level":"info","ts":"2026-07-26T17:42:22.865819Z","caller":"traceutil/trace.go:171","msg":"trace[1345007921] transaction","detail":"{read_only:false; response_revision:9971; number_of_response:1; }","duration":"141.647716ms","start":"2026-07-26T17:42:22.724148Z","end":"2026-07-26T17:42:22.865796Z","steps":["trace[1345007921] 'process raft request' (duration: 141.523893ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:42:23.123522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.03105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-26T17:42:23.123561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.137552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-26T17:42:23.123548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.081191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T17:42:23.12363Z","caller":"traceutil/trace.go:171","msg":"trace[608350383] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:9971; }","duration":"119.257715ms","start":"2026-07-26T17:42:23.004352Z","end":"2026-07-26T17:42:23.12361Z","steps":["trace[608350383] 'range keys from in-memory index tree' (duration: 119.0205ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:42:23.123683Z","caller":"traceutil/trace.go:171","msg":"trace[1520908907] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:9971; }","duration":"119.315236ms","start":"2026-07-26T17:42:23.004334Z","end":"2026-07-26T17:42:23.123649Z","steps":["trace[1520908907] 'range keys from in-memory index tree' (duration: 118.949678ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:42:23.12362Z","caller":"traceutil/trace.go:171","msg":"trace[122269924] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:9971; }","duration":"119.171613ms","start":"2026-07-26T17:42:23.004421Z","end":"2026-07-26T17:42:23.123593Z","steps":["trace[122269924] 'range keys from in-memory index tree' (duration: 118.950158ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:42:23.123522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.956799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-07-26T17:42:23.123868Z","caller":"traceutil/trace.go:171","msg":"trace[2116427348] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:9971; }","duration":"119.350076ms","start":"2026-07-26T17:42:23.004484Z","end":"2026-07-26T17:42:23.123834Z","steps":["trace[2116427348] 'range keys from in-memory index tree' (duration: 118.748563ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:46:46.149991Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9390} {"level":"info","ts":"2026-07-26T17:46:46.230491Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9390,"took":"78.162988ms","hash":343335751,"current-db-size-bytes":34803712,"current-db-size":"35 MB","current-db-size-in-use-bytes":19480576,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-07-26T17:46:46.230562Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":343335751,"revision":9390,"compact-revision":6488} {"level":"warn","ts":"2026-07-26T17:48:52.989727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.863193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-26T17:48:52.989894Z","caller":"traceutil/trace.go:171","msg":"trace[684005175] linearizableReadLoop","detail":"{readStateIndex:13308; appliedIndex:13306; }","duration":"107.804608ms","start":"2026-07-26T17:48:52.882073Z","end":"2026-07-26T17:48:52.989878Z","steps":["trace[684005175] 'read index received' (duration: 106.140275ms)","trace[684005175] 'applied index is now lower than readState.Index' (duration: 1.663103ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T17:48:52.990062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.960961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T17:48:52.990159Z","caller":"traceutil/trace.go:171","msg":"trace[24034482] transaction","detail":"{read_only:false; response_revision:12868; number_of_response:1; }","duration":"206.744675ms","start":"2026-07-26T17:48:52.783401Z","end":"2026-07-26T17:48:52.990146Z","steps":["trace[24034482] 'process raft request' (duration: 62.397683ms)","trace[24034482] 'compare' (duration: 143.541106ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:48:52.990175Z","caller":"traceutil/trace.go:171","msg":"trace[1050824364] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:12869; }","duration":"108.091583ms","start":"2026-07-26T17:48:52.882049Z","end":"2026-07-26T17:48:52.990141Z","steps":["trace[1050824364] 'agreement among raft nodes before linearized reading' (duration: 107.90568ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:48:52.990362Z","caller":"traceutil/trace.go:171","msg":"trace[214689833] transaction","detail":"{read_only:false; response_revision:12869; number_of_response:1; }","duration":"116.864133ms","start":"2026-07-26T17:48:52.873489Z","end":"2026-07-26T17:48:52.990353Z","steps":["trace[214689833] 'process raft request' (duration: 116.332182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:48:59.485162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.355418ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T17:48:59.485329Z","caller":"traceutil/trace.go:171","msg":"trace[1008703489] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:12904; }","duration":"155.560112ms","start":"2026-07-26T17:48:59.329745Z","end":"2026-07-26T17:48:59.485305Z","steps":["trace[1008703489] 'range keys from in-memory index tree' (duration: 155.323607ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:48:59.51405Z","caller":"traceutil/trace.go:171","msg":"trace[1365578809] linearizableReadLoop","detail":"{readStateIndex:13345; appliedIndex:13344; }","duration":"180.772895ms","start":"2026-07-26T17:48:59.333248Z","end":"2026-07-26T17:48:59.514021Z","steps":["trace[1365578809] 'read index received' (duration: 180.627612ms)","trace[1365578809] 'applied index is now lower than readState.Index' (duration: 144.063µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T17:48:59.514168Z","caller":"traceutil/trace.go:171","msg":"trace[1384293356] transaction","detail":"{read_only:false; response_revision:12905; number_of_response:1; }","duration":"188.87835ms","start":"2026-07-26T17:48:59.325254Z","end":"2026-07-26T17:48:59.514132Z","steps":["trace[1384293356] 'process raft request' (duration: 188.574834ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T17:48:59.514362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.064413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:138"} {"level":"info","ts":"2026-07-26T17:48:59.514416Z","caller":"traceutil/trace.go:171","msg":"trace[2061345175] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:12905; }","duration":"181.223026ms","start":"2026-07-26T17:48:59.33318Z","end":"2026-07-26T17:48:59.514404Z","steps":["trace[2061345175] 'agreement among raft nodes before linearized reading' (duration: 180.969531ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T17:51:46.164256Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12006} {"level":"info","ts":"2026-07-26T17:51:46.245662Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12006,"took":"78.429443ms","hash":3036847454,"current-db-size-bytes":34803712,"current-db-size":"35 MB","current-db-size-in-use-bytes":18984960,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-26T17:51:46.245721Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3036847454,"revision":12006,"compact-revision":9390} {"level":"info","ts":"2026-07-26T17:56:46.171326Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13916} {"level":"info","ts":"2026-07-26T17:56:46.251276Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13916,"took":"76.873009ms","hash":225413756,"current-db-size-bytes":34803712,"current-db-size":"35 MB","current-db-size-in-use-bytes":14544896,"current-db-size-in-use":"14 MB"} {"level":"info","ts":"2026-07-26T17:56:46.251332Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":225413756,"revision":13916,"compact-revision":12006} {"level":"info","ts":"2026-07-26T18:01:46.177442Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15489} {"level":"info","ts":"2026-07-26T18:01:46.2489Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15489,"took":"68.179537ms","hash":3567419159,"current-db-size-bytes":34803712,"current-db-size":"35 MB","current-db-size-in-use-bytes":14999552,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-26T18:01:46.248987Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3567419159,"revision":15489,"compact-revision":13916}