{"level":"warn","ts":"2026-05-19T18:44:41.938517Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T18:44:41.938658Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.111: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.19.213.111:2380","--initial-cluster=instance=https://199.19.213.111:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.111:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.111: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-05-19T18:44:41.93907Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T18:44:41.939093Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.111:2380"]} {"level":"info","ts":"2026-05-19T18:44:41.939119Z","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-05-19T18:44:41.941007Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.111:2379"]} {"level":"info","ts":"2026-05-19T18:44:41.941217Z","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.19.213.111:2380"],"listen-peer-urls":["https://199.19.213.111:2380"],"advertise-client-urls":["https://199.19.213.111:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.111:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.111: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-05-19T18:44:41.94718Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.960475ms"} {"level":"info","ts":"2026-05-19T18:44:41.959993Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4edbe0dc99dceaa8","cluster-id":"9f725a00b80fcc82"} {"level":"info","ts":"2026-05-19T18:44:41.960222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T18:44:41.960258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 became follower at term 0"} {"level":"info","ts":"2026-05-19T18:44:41.96027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4edbe0dc99dceaa8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T18:44:41.96029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 became follower at term 1"} {"level":"info","ts":"2026-05-19T18:44:41.960376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 switched to configuration voters=(5682382592936831656)"} {"level":"warn","ts":"2026-05-19T18:44:41.972742Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T18:44:41.974314Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T18:44:41.975504Z","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-05-19T18:44:41.977787Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4edbe0dc99dceaa8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T18:44:41.977893Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4edbe0dc99dceaa8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T18:44:41.981192Z","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-05-19T18:44:41.981304Z","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-05-19T18:44:41.981321Z","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-05-19T18:44:41.98144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 switched to configuration voters=(5682382592936831656)"} {"level":"info","ts":"2026-05-19T18:44:41.981809Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9f725a00b80fcc82","local-member-id":"4edbe0dc99dceaa8","added-peer-id":"4edbe0dc99dceaa8","added-peer-peer-urls":["https://199.19.213.111:2380"]} {"level":"info","ts":"2026-05-19T18:44:41.985757Z","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-05-19T18:44:41.986016Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4edbe0dc99dceaa8","initial-advertise-peer-urls":["https://199.19.213.111:2380"],"listen-peer-urls":["https://199.19.213.111:2380"],"advertise-client-urls":["https://199.19.213.111:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.111:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T18:44:41.986066Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T18:44:41.986208Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.111:2380"} {"level":"info","ts":"2026-05-19T18:44:41.986224Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.111:2380"} {"level":"info","ts":"2026-05-19T18:44:42.361095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T18:44:42.361195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T18:44:42.361217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 received MsgPreVoteResp from 4edbe0dc99dceaa8 at term 1"} {"level":"info","ts":"2026-05-19T18:44:42.361237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 became candidate at term 2"} {"level":"info","ts":"2026-05-19T18:44:42.361255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 received MsgVoteResp from 4edbe0dc99dceaa8 at term 2"} {"level":"info","ts":"2026-05-19T18:44:42.361276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 became leader at term 2"} {"level":"info","ts":"2026-05-19T18:44:42.361294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4edbe0dc99dceaa8 elected leader 4edbe0dc99dceaa8 at term 2"} {"level":"info","ts":"2026-05-19T18:44:42.593013Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4edbe0dc99dceaa8","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.111:2379]}","request-path":"/0/members/4edbe0dc99dceaa8/attributes","cluster-id":"9f725a00b80fcc82","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T18:44:42.593245Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T18:44:42.593364Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T18:44:42.593443Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T18:44:42.59366Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T18:44:42.593716Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:44:42.596542Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.111:2379"} {"level":"info","ts":"2026-05-19T18:44:42.597356Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T18:44:42.66512Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9f725a00b80fcc82","local-member-id":"4edbe0dc99dceaa8","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:44:42.665329Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:44:42.665421Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-19T18:44:42.989856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.521186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-19T18:44:42.989919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.079062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.989972Z","caller":"traceutil/trace.go:171","msg":"trace[1822501685] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"128.690749ms","start":"2026-05-19T18:44:42.861264Z","end":"2026-05-19T18:44:42.989955Z","steps":["trace[1822501685] 'count revisions from in-memory index tree' (duration: 128.439545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.989988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.693788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-19T18:44:42.990054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.965166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.990067Z","caller":"traceutil/trace.go:171","msg":"trace[655977631] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"157.81367ms","start":"2026-05-19T18:44:42.832239Z","end":"2026-05-19T18:44:42.990052Z","steps":["trace[655977631] 'count revisions from in-memory index tree' (duration: 157.557875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.990114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.900434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-19T18:44:42.990248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.751839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-19T18:44:42.990262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.372395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.99028Z","caller":"traceutil/trace.go:171","msg":"trace[1464452204] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"157.863581ms","start":"2026-05-19T18:44:42.832406Z","end":"2026-05-19T18:44:42.99027Z","steps":["trace[1464452204] 'range keys from in-memory index tree' (duration: 157.646247ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:44:42.990268Z","caller":"traceutil/trace.go:171","msg":"trace[2004537808] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"205.039276ms","start":"2026-05-19T18:44:42.785151Z","end":"2026-05-19T18:44:42.99019Z","steps":["trace[2004537808] 'count revisions from in-memory index tree' (duration: 204.830843ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:44:42.99029Z","caller":"traceutil/trace.go:171","msg":"trace[2024819347] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"175.402056ms","start":"2026-05-19T18:44:42.814878Z","end":"2026-05-19T18:44:42.99028Z","steps":["trace[2024819347] 'range keys from in-memory index tree' (duration: 175.266583ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:44:42.99Z","caller":"traceutil/trace.go:171","msg":"trace[1940939256] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"188.201314ms","start":"2026-05-19T18:44:42.801775Z","end":"2026-05-19T18:44:42.989976Z","steps":["trace[1940939256] 'count revisions from in-memory index tree' (duration: 187.97205ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.990411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.561988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.990429Z","caller":"traceutil/trace.go:171","msg":"trace[1582155354] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"141.603849ms","start":"2026-05-19T18:44:42.84882Z","end":"2026-05-19T18:44:42.990423Z","steps":["trace[1582155354] 'range keys from in-memory index tree' (duration: 141.403075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.990544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.927872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.990582Z","caller":"traceutil/trace.go:171","msg":"trace[1096088541] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"102.003713ms","start":"2026-05-19T18:44:42.888564Z","end":"2026-05-19T18:44:42.990568Z","steps":["trace[1096088541] 'range keys from in-memory index tree' (duration: 101.8201ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.990527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.110117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.990669Z","caller":"traceutil/trace.go:171","msg":"trace[1897516292] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"129.27325ms","start":"2026-05-19T18:44:42.861373Z","end":"2026-05-19T18:44:42.990647Z","steps":["trace[1897516292] 'range keys from in-memory index tree' (duration: 129.036576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.990728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.958503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.990762Z","caller":"traceutil/trace.go:171","msg":"trace[955849423] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"102.026684ms","start":"2026-05-19T18:44:42.888723Z","end":"2026-05-19T18:44:42.99075Z","steps":["trace[955849423] 'count revisions from in-memory index tree' (duration: 101.877061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.990831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.381391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.990918Z","caller":"traceutil/trace.go:171","msg":"trace[390177801] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"220.636497ms","start":"2026-05-19T18:44:42.770269Z","end":"2026-05-19T18:44:42.990905Z","steps":["trace[390177801] 'range keys from in-memory index tree' (duration: 220.348191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.9909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.924717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-19T18:44:42.991025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.011148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.991048Z","caller":"traceutil/trace.go:171","msg":"trace[1368332269] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"176.08329ms","start":"2026-05-19T18:44:42.814958Z","end":"2026-05-19T18:44:42.991041Z","steps":["trace[1368332269] 'count revisions from in-memory index tree' (duration: 175.911976ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:44:42.991037Z","caller":"traceutil/trace.go:171","msg":"trace[399916511] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"189.417147ms","start":"2026-05-19T18:44:42.801583Z","end":"2026-05-19T18:44:42.991Z","steps":["trace[399916511] 'range keys from in-memory index tree' (duration: 188.824756ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:44:42.990149Z","caller":"traceutil/trace.go:171","msg":"trace[1874887562] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"205.042836ms","start":"2026-05-19T18:44:42.78504Z","end":"2026-05-19T18:44:42.990083Z","steps":["trace[1874887562] 'range keys from in-memory index tree' (duration: 204.804423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.990386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.502697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-19T18:44:42.99137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.438943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.991374Z","caller":"traceutil/trace.go:171","msg":"trace[1926110617] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"142.507777ms","start":"2026-05-19T18:44:42.848852Z","end":"2026-05-19T18:44:42.99136Z","steps":["trace[1926110617] 'count revisions from in-memory index tree' (duration: 141.386135ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:44:42.991393Z","caller":"traceutil/trace.go:171","msg":"trace[228074471] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"116.461973ms","start":"2026-05-19T18:44:42.874924Z","end":"2026-05-19T18:44:42.991386Z","steps":["trace[228074471] 'count revisions from in-memory index tree' (duration: 116.387712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.9914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.650746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.991442Z","caller":"traceutil/trace.go:171","msg":"trace[1380331170] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"116.721508ms","start":"2026-05-19T18:44:42.874712Z","end":"2026-05-19T18:44:42.991434Z","steps":["trace[1380331170] 'range keys from in-memory index tree' (duration: 116.393482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:44:42.991201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.966582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:44:42.991607Z","caller":"traceutil/trace.go:171","msg":"trace[1735723021] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"221.37911ms","start":"2026-05-19T18:44:42.770217Z","end":"2026-05-19T18:44:42.991596Z","steps":["trace[1735723021] 'count revisions from in-memory index tree' (duration: 220.85005ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:13.420687Z","caller":"traceutil/trace.go:171","msg":"trace[1924759117] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"122.71878ms","start":"2026-05-19T18:45:13.297944Z","end":"2026-05-19T18:45:13.420663Z","steps":["trace[1924759117] 'process raft request' (duration: 122.595989ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:13.428464Z","caller":"traceutil/trace.go:171","msg":"trace[103441348] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"114.828161ms","start":"2026-05-19T18:45:13.313615Z","end":"2026-05-19T18:45:13.428443Z","steps":["trace[103441348] 'process raft request' (duration: 114.241074ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:13.428687Z","caller":"traceutil/trace.go:171","msg":"trace[1010827596] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"112.315179ms","start":"2026-05-19T18:45:13.31636Z","end":"2026-05-19T18:45:13.428675Z","steps":["trace[1010827596] 'process raft request' (duration: 111.57191ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:13.753307Z","caller":"traceutil/trace.go:171","msg":"trace[939324960] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"119.55421ms","start":"2026-05-19T18:45:13.633734Z","end":"2026-05-19T18:45:13.753288Z","steps":["trace[939324960] 'process raft request' (duration: 119.358138ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:13.758676Z","caller":"traceutil/trace.go:171","msg":"trace[1183098570] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"110.616117ms","start":"2026-05-19T18:45:13.647241Z","end":"2026-05-19T18:45:13.757857Z","steps":["trace[1183098570] 'process raft request' (duration: 109.905578ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:15.987863Z","caller":"traceutil/trace.go:171","msg":"trace[1037702182] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"210.387984ms","start":"2026-05-19T18:45:15.777409Z","end":"2026-05-19T18:45:15.987797Z","steps":["trace[1037702182] 'read index received' (duration: 210.088321ms)","trace[1037702182] 'applied index is now lower than readState.Index' (duration: 297.753µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:45:15.98842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.986592ms","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-05-19T18:45:15.9891Z","caller":"traceutil/trace.go:171","msg":"trace[724613977] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"211.152625ms","start":"2026-05-19T18:45:15.777364Z","end":"2026-05-19T18:45:15.988516Z","steps":["trace[724613977] 'agreement among raft nodes before linearized reading' (duration: 210.73388ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:19.79182Z","caller":"traceutil/trace.go:171","msg":"trace[943096131] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"306.757017ms","start":"2026-05-19T18:45:19.485027Z","end":"2026-05-19T18:45:19.791784Z","steps":["trace[943096131] 'process raft request' (duration: 305.860697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:19.792393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:19.485003Z","time spent":"306.90893ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:45:20.105075Z","caller":"traceutil/trace.go:171","msg":"trace[1206007841] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"293.658523ms","start":"2026-05-19T18:45:19.811392Z","end":"2026-05-19T18:45:20.105051Z","steps":["trace[1206007841] 'process raft request' (duration: 293.510361ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:20.113068Z","caller":"traceutil/trace.go:171","msg":"trace[122173950] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"259.686087ms","start":"2026-05-19T18:45:19.853364Z","end":"2026-05-19T18:45:20.11305Z","steps":["trace[122173950] 'process raft request' (duration: 259.570105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:20.851454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.806143ms","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-05-19T18:45:20.851611Z","caller":"traceutil/trace.go:171","msg":"trace[1031048794] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"559.012575ms","start":"2026-05-19T18:45:20.292564Z","end":"2026-05-19T18:45:20.851576Z","steps":["trace[1031048794] 'range keys from in-memory index tree' (duration: 558.54311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:20.851734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:20.292551Z","time spent":"559.166617ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T18:45:20.852766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.860382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:45:20.852892Z","caller":"traceutil/trace.go:171","msg":"trace[1782569736] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"613.026083ms","start":"2026-05-19T18:45:20.23982Z","end":"2026-05-19T18:45:20.852846Z","steps":["trace[1782569736] 'range keys from in-memory index tree' (duration: 612.768561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:20.852947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:20.239804Z","time spent":"613.132935ms","remote":"127.0.0.1:37572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T18:45:21.21292Z","caller":"traceutil/trace.go:171","msg":"trace[1105412450] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"358.615145ms","start":"2026-05-19T18:45:20.854286Z","end":"2026-05-19T18:45:21.212902Z","steps":["trace[1105412450] 'read index received' (duration: 358.132938ms)","trace[1105412450] 'applied index is now lower than readState.Index' (duration: 481.347µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:45:21.213043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.739596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:45:21.213073Z","caller":"traceutil/trace.go:171","msg":"trace[520503975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"358.818728ms","start":"2026-05-19T18:45:20.854244Z","end":"2026-05-19T18:45:21.213063Z","steps":["trace[520503975] 'agreement among raft nodes before linearized reading' (duration: 358.741407ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:21.213023Z","caller":"traceutil/trace.go:171","msg":"trace[876670153] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"637.860079ms","start":"2026-05-19T18:45:20.575088Z","end":"2026-05-19T18:45:21.212948Z","steps":["trace[876670153] 'process raft request' (duration: 637.392374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:21.213101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:20.854227Z","time spent":"358.869488ms","remote":"127.0.0.1:37576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T18:45:21.2135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:20.575051Z","time spent":"638.210184ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:45:21.217667Z","caller":"traceutil/trace.go:171","msg":"trace[2042940031] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"359.847379ms","start":"2026-05-19T18:45:20.857776Z","end":"2026-05-19T18:45:21.217623Z","steps":["trace[2042940031] 'process raft request' (duration: 359.687937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:21.218088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:20.85776Z","time spent":"360.164442ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:45:21.227871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.051122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:45:21.227935Z","caller":"traceutil/trace.go:171","msg":"trace[264032114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"350.165034ms","start":"2026-05-19T18:45:20.877755Z","end":"2026-05-19T18:45:21.22792Z","steps":["trace[264032114] 'agreement among raft nodes before linearized reading' (duration: 350.005832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:21.227963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:20.877736Z","time spent":"350.221594ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T18:46:14.964774Z","caller":"traceutil/trace.go:171","msg":"trace[753113265] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"421.029324ms","start":"2026-05-19T18:46:14.543698Z","end":"2026-05-19T18:46:14.964727Z","steps":["trace[753113265] 'process raft request' (duration: 404.313352ms)","trace[753113265] 'compare' (duration: 16.363746ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:46:14.965023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:14.543671Z","time spent":"421.218648ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:46:33.791779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.420718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-19T18:46:33.791819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.549738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:46:33.791872Z","caller":"traceutil/trace.go:171","msg":"trace[1850919985] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1449; }","duration":"171.561691ms","start":"2026-05-19T18:46:33.620291Z","end":"2026-05-19T18:46:33.791853Z","steps":["trace[1850919985] 'range keys from in-memory index tree' (duration: 171.238755ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:33.791894Z","caller":"traceutil/trace.go:171","msg":"trace[300656642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1449; }","duration":"157.66909ms","start":"2026-05-19T18:46:33.634207Z","end":"2026-05-19T18:46:33.791877Z","steps":["trace[300656642] 'range keys from in-memory index tree' (duration: 157.381236ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:36.386364Z","caller":"traceutil/trace.go:171","msg":"trace[221022181] linearizableReadLoop","detail":"{readStateIndex:1512; appliedIndex:1511; }","duration":"143.724317ms","start":"2026-05-19T18:46:36.242615Z","end":"2026-05-19T18:46:36.386339Z","steps":["trace[221022181] 'read index received' (duration: 143.462233ms)","trace[221022181] 'applied index is now lower than readState.Index' (duration: 260.974µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:46:36.386495Z","caller":"traceutil/trace.go:171","msg":"trace[362502905] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"189.643987ms","start":"2026-05-19T18:46:36.196838Z","end":"2026-05-19T18:46:36.386482Z","steps":["trace[362502905] 'process raft request' (duration: 189.341373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:36.386705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.077994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:36.38682Z","caller":"traceutil/trace.go:171","msg":"trace[1542711407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1468; }","duration":"144.231286ms","start":"2026-05-19T18:46:36.242563Z","end":"2026-05-19T18:46:36.386795Z","steps":["trace[1542711407] 'agreement among raft nodes before linearized reading' (duration: 144.065553ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:36.644307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.865709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:46:36.644433Z","caller":"traceutil/trace.go:171","msg":"trace[1364033042] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"167.434165ms","start":"2026-05-19T18:46:36.476971Z","end":"2026-05-19T18:46:36.644405Z","steps":["trace[1364033042] 'process raft request' (duration: 53.21144ms)","trace[1364033042] 'compare' (duration: 113.746457ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:46:59.534979Z","caller":"traceutil/trace.go:171","msg":"trace[20316665] linearizableReadLoop","detail":"{readStateIndex:1938; appliedIndex:1937; }","duration":"269.814551ms","start":"2026-05-19T18:46:59.265147Z","end":"2026-05-19T18:46:59.534961Z","steps":["trace[20316665] 'read index received' (duration: 269.582277ms)","trace[20316665] 'applied index is now lower than readState.Index' (duration: 231.684µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:46:59.535031Z","caller":"traceutil/trace.go:171","msg":"trace[1770546452] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"292.43167ms","start":"2026-05-19T18:46:59.242577Z","end":"2026-05-19T18:46:59.535009Z","steps":["trace[1770546452] 'process raft request' (duration: 292.201757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:59.535185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.032844ms","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-05-19T18:46:59.535227Z","caller":"traceutil/trace.go:171","msg":"trace[2064077062] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1869; }","duration":"270.125895ms","start":"2026-05-19T18:46:59.265091Z","end":"2026-05-19T18:46:59.535217Z","steps":["trace[2064077062] 'agreement among raft nodes before linearized reading' (duration: 269.962533ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:47:00.055806Z","caller":"traceutil/trace.go:171","msg":"trace[1393163436] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1938; }","duration":"146.735384ms","start":"2026-05-19T18:46:59.909041Z","end":"2026-05-19T18:47:00.055776Z","steps":["trace[1393163436] 'read index received' (duration: 146.582972ms)","trace[1393163436] 'applied index is now lower than readState.Index' (duration: 151.452µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:47:00.055936Z","caller":"traceutil/trace.go:171","msg":"trace[457710196] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"501.515702ms","start":"2026-05-19T18:46:59.55438Z","end":"2026-05-19T18:47:00.055896Z","steps":["trace[457710196] 'process raft request' (duration: 501.172267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:00.056107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:59.554358Z","time spent":"501.659223ms","remote":"127.0.0.1:37780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10932,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:47:00.056228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.134679ms","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-05-19T18:47:00.056278Z","caller":"traceutil/trace.go:171","msg":"trace[1955728439] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1870; }","duration":"147.276572ms","start":"2026-05-19T18:46:59.908989Z","end":"2026-05-19T18:47:00.056266Z","steps":["trace[1955728439] 'agreement among raft nodes before linearized reading' (duration: 146.919867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:00.070306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.859959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:47:00.070485Z","caller":"traceutil/trace.go:171","msg":"trace[922110272] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1871; }","duration":"159.077143ms","start":"2026-05-19T18:46:59.911385Z","end":"2026-05-19T18:47:00.070462Z","steps":["trace[922110272] 'agreement among raft nodes before linearized reading' (duration: 158.796289ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:47:00.070543Z","caller":"traceutil/trace.go:171","msg":"trace[595452763] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"136.806369ms","start":"2026-05-19T18:46:59.933715Z","end":"2026-05-19T18:47:00.070521Z","steps":["trace[595452763] 'process raft request' (duration: 136.369832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:00.540718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.312915ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:47:00.541137Z","caller":"traceutil/trace.go:171","msg":"trace[1952482525] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"467.353037ms","start":"2026-05-19T18:47:00.073683Z","end":"2026-05-19T18:47:00.541036Z","steps":["trace[1952482525] 'process raft request' (duration: 106.568195ms)","trace[1952482525] 'compare' (duration: 360.160813ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:47:00.541271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:47:00.073669Z","time spent":"467.543141ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:47:00.541625Z","caller":"traceutil/trace.go:171","msg":"trace[463187389] linearizableReadLoop","detail":"{readStateIndex:1946; appliedIndex:1945; }","duration":"358.383487ms","start":"2026-05-19T18:47:00.183222Z","end":"2026-05-19T18:47:00.541606Z","steps":["trace[463187389] 'read index received' (duration: 66.201µs)","trace[463187389] 'applied index is now lower than readState.Index' (duration: 358.315086ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:47:00.54188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.646611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-72180e32-bd6c-4c66-8d52-971b68a52917\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-05-19T18:47:00.541923Z","caller":"traceutil/trace.go:171","msg":"trace[231721801] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-72180e32-bd6c-4c66-8d52-971b68a52917; range_end:; response_count:1; response_revision:1878; }","duration":"358.730623ms","start":"2026-05-19T18:47:00.18318Z","end":"2026-05-19T18:47:00.541911Z","steps":["trace[231721801] 'agreement among raft nodes before linearized reading' (duration: 358.484159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:00.541951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:47:00.183157Z","time spent":"358.788013ms","remote":"127.0.0.1:37780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3770,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-72180e32-bd6c-4c66-8d52-971b68a52917\" "} {"level":"warn","ts":"2026-05-19T18:47:00.550109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.844134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:47:00.550183Z","caller":"traceutil/trace.go:171","msg":"trace[1680945018] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1879; }","duration":"307.965706ms","start":"2026-05-19T18:47:00.242205Z","end":"2026-05-19T18:47:00.55017Z","steps":["trace[1680945018] 'agreement among raft nodes before linearized reading' (duration: 307.862235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:00.550214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:47:00.24219Z","time spent":"308.016597ms","remote":"127.0.0.1:37572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T18:47:00.550121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.638533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T18:47:00.550384Z","caller":"traceutil/trace.go:171","msg":"trace[722445431] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1879; }","duration":"272.965448ms","start":"2026-05-19T18:47:00.277406Z","end":"2026-05-19T18:47:00.550371Z","steps":["trace[722445431] 'agreement among raft nodes before linearized reading' (duration: 272.588613ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:47:12.805777Z","caller":"traceutil/trace.go:171","msg":"trace[1590580166] linearizableReadLoop","detail":"{readStateIndex:2052; appliedIndex:2050; }","duration":"184.642971ms","start":"2026-05-19T18:47:12.621095Z","end":"2026-05-19T18:47:12.805738Z","steps":["trace[1590580166] 'read index received' (duration: 16.787122ms)","trace[1590580166] 'applied index is now lower than readState.Index' (duration: 167.854389ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:47:12.806194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.058516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-19T18:47:12.806304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.169554ms","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-05-19T18:47:12.806355Z","caller":"traceutil/trace.go:171","msg":"trace[1649752959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1979; }","duration":"185.291449ms","start":"2026-05-19T18:47:12.621044Z","end":"2026-05-19T18:47:12.806335Z","steps":["trace[1649752959] 'agreement among raft nodes before linearized reading' (duration: 184.855813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:12.806194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.516693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-19T18:47:12.806392Z","caller":"traceutil/trace.go:171","msg":"trace[1750137931] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1979; }","duration":"134.324245ms","start":"2026-05-19T18:47:12.672028Z","end":"2026-05-19T18:47:12.806352Z","steps":["trace[1750137931] 'agreement among raft nodes before linearized reading' (duration: 133.980081ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:47:12.806502Z","caller":"traceutil/trace.go:171","msg":"trace[1178683469] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1979; }","duration":"146.896909ms","start":"2026-05-19T18:47:12.659577Z","end":"2026-05-19T18:47:12.806474Z","steps":["trace[1178683469] 'agreement among raft nodes before linearized reading' (duration: 146.418733ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:47:12.805891Z","caller":"traceutil/trace.go:171","msg":"trace[441097644] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"192.891895ms","start":"2026-05-19T18:47:12.612932Z","end":"2026-05-19T18:47:12.805824Z","steps":["trace[441097644] 'process raft request' (duration: 192.454479ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:47:38.729534Z","caller":"traceutil/trace.go:171","msg":"trace[1205837431] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"104.68924ms","start":"2026-05-19T18:47:38.624818Z","end":"2026-05-19T18:47:38.729507Z","steps":["trace[1205837431] 'process raft request' (duration: 104.543268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:50.038325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.975813ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:47:50.038441Z","caller":"traceutil/trace.go:171","msg":"trace[1984859926] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"463.580956ms","start":"2026-05-19T18:47:49.574836Z","end":"2026-05-19T18:47:50.038417Z","steps":["trace[1984859926] 'process raft request' (duration: 215.431891ms)","trace[1984859926] 'compare' (duration: 247.807041ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:47:50.038531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:47:49.574806Z","time spent":"463.676098ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:47:50.084235Z","caller":"traceutil/trace.go:171","msg":"trace[809326571] linearizableReadLoop","detail":"{readStateIndex:2272; appliedIndex:2270; }","duration":"342.684981ms","start":"2026-05-19T18:47:49.741526Z","end":"2026-05-19T18:47:50.084211Z","steps":["trace[809326571] 'read index received' (duration: 48.766282ms)","trace[809326571] 'applied index is now lower than readState.Index' (duration: 293.917559ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:47:50.084397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.856103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:47:50.084435Z","caller":"traceutil/trace.go:171","msg":"trace[1175915081] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2192; }","duration":"342.917203ms","start":"2026-05-19T18:47:49.741504Z","end":"2026-05-19T18:47:50.084422Z","steps":["trace[1175915081] 'agreement among raft nodes before linearized reading' (duration: 342.798982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:50.084484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:47:49.741439Z","time spent":"343.035095ms","remote":"127.0.0.1:37720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-19T18:47:50.084472Z","caller":"traceutil/trace.go:171","msg":"trace[1084371028] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"508.240136ms","start":"2026-05-19T18:47:49.576192Z","end":"2026-05-19T18:47:50.084432Z","steps":["trace[1084371028] 'process raft request' (duration: 507.888582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:50.084774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:47:49.576178Z","time spent":"508.466069ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:47:50.450994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.923085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:47:50.451091Z","caller":"traceutil/trace.go:171","msg":"trace[1605099966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2192; }","duration":"209.058456ms","start":"2026-05-19T18:47:50.242007Z","end":"2026-05-19T18:47:50.451066Z","steps":["trace[1605099966] 'range keys from in-memory index tree' (duration: 208.854533ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:50.45126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.430576ms","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-05-19T18:47:50.451335Z","caller":"traceutil/trace.go:171","msg":"trace[1847688231] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2192; }","duration":"297.544528ms","start":"2026-05-19T18:47:50.153759Z","end":"2026-05-19T18:47:50.451303Z","steps":["trace[1847688231] 'range keys from in-memory index tree' (duration: 297.142073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:47:59.362314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.366362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:47:59.362443Z","caller":"traceutil/trace.go:171","msg":"trace[400405246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2242; }","duration":"119.573224ms","start":"2026-05-19T18:47:59.242835Z","end":"2026-05-19T18:47:59.362409Z","steps":["trace[400405246] 'range keys from in-memory index tree' (duration: 119.264471ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:16.296357Z","caller":"traceutil/trace.go:171","msg":"trace[1753115886] transaction","detail":"{read_only:false; response_revision:2351; number_of_response:1; }","duration":"116.716167ms","start":"2026-05-19T18:48:16.179596Z","end":"2026-05-19T18:48:16.296312Z","steps":["trace[1753115886] 'process raft request' (duration: 104.656246ms)","trace[1753115886] 'compare' (duration: 11.559125ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:31.321585Z","caller":"traceutil/trace.go:171","msg":"trace[1462205587] transaction","detail":"{read_only:false; response_revision:2516; number_of_response:1; }","duration":"343.273245ms","start":"2026-05-19T18:48:30.978275Z","end":"2026-05-19T18:48:31.321549Z","steps":["trace[1462205587] 'process raft request' (duration: 343.063933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:31.321843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:30.978247Z","time spent":"343.457098ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:48:31.323187Z","caller":"traceutil/trace.go:171","msg":"trace[559124941] transaction","detail":"{read_only:false; response_revision:2517; number_of_response:1; }","duration":"180.763641ms","start":"2026-05-19T18:48:31.142407Z","end":"2026-05-19T18:48:31.323171Z","steps":["trace[559124941] 'process raft request' (duration: 180.164184ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:57.547394Z","caller":"traceutil/trace.go:171","msg":"trace[926969711] transaction","detail":"{read_only:false; response_revision:2663; number_of_response:1; }","duration":"113.053451ms","start":"2026-05-19T18:48:57.434313Z","end":"2026-05-19T18:48:57.547366Z","steps":["trace[926969711] 'process raft request' (duration: 112.864829ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:57.560201Z","caller":"traceutil/trace.go:171","msg":"trace[1433485020] transaction","detail":"{read_only:false; response_revision:2664; number_of_response:1; }","duration":"116.848301ms","start":"2026-05-19T18:48:57.443316Z","end":"2026-05-19T18:48:57.560164Z","steps":["trace[1433485020] 'process raft request' (duration: 116.580458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:49:03.014403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.185528ms","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-05-19T18:49:03.014489Z","caller":"traceutil/trace.go:171","msg":"trace[1516505289] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2692; }","duration":"116.35076ms","start":"2026-05-19T18:49:02.89812Z","end":"2026-05-19T18:49:03.014471Z","steps":["trace[1516505289] 'range keys from in-memory index tree' (duration: 115.951145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:49:03.014471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.889261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"} {"level":"info","ts":"2026-05-19T18:49:03.01464Z","caller":"traceutil/trace.go:171","msg":"trace[705604190] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2692; }","duration":"214.232895ms","start":"2026-05-19T18:49:02.800358Z","end":"2026-05-19T18:49:03.014591Z","steps":["trace[705604190] 'range keys from in-memory index tree' (duration: 213.586459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:49:03.492692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.796469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:49:03.492817Z","caller":"traceutil/trace.go:171","msg":"trace[218153099] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2693; }","duration":"250.990921ms","start":"2026-05-19T18:49:03.241798Z","end":"2026-05-19T18:49:03.492789Z","steps":["trace[218153099] 'range keys from in-memory index tree' (duration: 250.579457ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:09.760299Z","caller":"traceutil/trace.go:171","msg":"trace[2103557223] transaction","detail":"{read_only:false; response_revision:4605; number_of_response:1; }","duration":"157.205197ms","start":"2026-05-19T18:53:09.603066Z","end":"2026-05-19T18:53:09.760271Z","steps":["trace[2103557223] 'process raft request' (duration: 150.331141ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:09.845187Z","caller":"traceutil/trace.go:171","msg":"trace[2040919043] transaction","detail":"{read_only:false; response_revision:4606; number_of_response:1; }","duration":"227.863938ms","start":"2026-05-19T18:53:09.617295Z","end":"2026-05-19T18:53:09.845159Z","steps":["trace[2040919043] 'process raft request' (duration: 227.693194ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:10.396221Z","caller":"traceutil/trace.go:171","msg":"trace[945774763] transaction","detail":"{read_only:false; response_revision:4617; number_of_response:1; }","duration":"146.615822ms","start":"2026-05-19T18:53:10.249569Z","end":"2026-05-19T18:53:10.396185Z","steps":["trace[945774763] 'process raft request' (duration: 146.408628ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:18.500868Z","caller":"traceutil/trace.go:171","msg":"trace[1330400331] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"285.387768ms","start":"2026-05-19T18:53:18.215447Z","end":"2026-05-19T18:53:18.500835Z","steps":["trace[1330400331] 'process raft request' (duration: 285.0695ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:18.687589Z","caller":"traceutil/trace.go:171","msg":"trace[1295674951] transaction","detail":"{read_only:false; response_revision:4788; number_of_response:1; }","duration":"471.751278ms","start":"2026-05-19T18:53:18.215814Z","end":"2026-05-19T18:53:18.687566Z","steps":["trace[1295674951] 'process raft request' (duration: 471.525793ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:18.687904Z","caller":"traceutil/trace.go:171","msg":"trace[596657907] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"468.726235ms","start":"2026-05-19T18:53:18.219158Z","end":"2026-05-19T18:53:18.687884Z","steps":["trace[596657907] 'process raft request' (duration: 468.347337ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:18.688018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:53:18.219148Z","time spent":"468.802607ms","remote":"127.0.0.1:37780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:53:18.688048Z","caller":"traceutil/trace.go:171","msg":"trace[385833336] linearizableReadLoop","detail":"{readStateIndex:4968; appliedIndex:4965; }","duration":"445.04181ms","start":"2026-05-19T18:53:18.242995Z","end":"2026-05-19T18:53:18.688037Z","steps":["trace[385833336] 'read index received' (duration: 257.559036ms)","trace[385833336] 'applied index is now lower than readState.Index' (duration: 187.481874ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:53:18.688231Z","caller":"traceutil/trace.go:171","msg":"trace[1824016083] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"305.810654ms","start":"2026-05-19T18:53:18.382413Z","end":"2026-05-19T18:53:18.688224Z","steps":["trace[1824016083] 'process raft request' (duration: 305.303734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:18.688285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:53:18.382347Z","time spent":"305.896317ms","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10682,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:53:18.688301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.314936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:53:18.688329Z","caller":"traceutil/trace.go:171","msg":"trace[1054179198] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4790; }","duration":"445.377657ms","start":"2026-05-19T18:53:18.242941Z","end":"2026-05-19T18:53:18.688319Z","steps":["trace[1054179198] 'agreement among raft nodes before linearized reading' (duration: 445.333036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:18.688353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:53:18.242929Z","time spent":"445.416519ms","remote":"127.0.0.1:37572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T18:53:18.688905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:53:18.215787Z","time spent":"471.889221ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:53:18.713336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.903889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T18:53:18.713445Z","caller":"traceutil/trace.go:171","msg":"trace[287318841] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4792; }","duration":"138.064652ms","start":"2026-05-19T18:53:18.575353Z","end":"2026-05-19T18:53:18.713417Z","steps":["trace[287318841] 'agreement among raft nodes before linearized reading' (duration: 137.804927ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:18.714056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.570374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T18:53:18.71424Z","caller":"traceutil/trace.go:171","msg":"trace[368947707] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4792; }","duration":"173.769728ms","start":"2026-05-19T18:53:18.540411Z","end":"2026-05-19T18:53:18.71418Z","steps":["trace[368947707] 'agreement among raft nodes before linearized reading' (duration: 173.493562ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:19.243032Z","caller":"traceutil/trace.go:171","msg":"trace[1618075366] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"228.508638ms","start":"2026-05-19T18:53:19.014496Z","end":"2026-05-19T18:53:19.243005Z","steps":["trace[1618075366] 'process raft request' (duration: 228.297194ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:19.273847Z","caller":"traceutil/trace.go:171","msg":"trace[1451710127] linearizableReadLoop","detail":"{readStateIndex:4974; appliedIndex:4972; }","duration":"203.592279ms","start":"2026-05-19T18:53:19.070227Z","end":"2026-05-19T18:53:19.27382Z","steps":["trace[1451710127] 'read index received' (duration: 172.512772ms)","trace[1451710127] 'applied index is now lower than readState.Index' (duration: 31.078767ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:53:19.274061Z","caller":"traceutil/trace.go:171","msg":"trace[1204290187] transaction","detail":"{read_only:false; response_revision:4795; number_of_response:1; }","duration":"259.052925ms","start":"2026-05-19T18:53:19.014969Z","end":"2026-05-19T18:53:19.274022Z","steps":["trace[1204290187] 'process raft request' (duration: 258.766099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:19.274169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.912047ms","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-05-19T18:53:19.274252Z","caller":"traceutil/trace.go:171","msg":"trace[259785842] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4795; }","duration":"204.06345ms","start":"2026-05-19T18:53:19.070167Z","end":"2026-05-19T18:53:19.27423Z","steps":["trace[259785842] 'agreement among raft nodes before linearized reading' (duration: 203.769044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:19.468592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.598338ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:53:19.468722Z","caller":"traceutil/trace.go:171","msg":"trace[671776535] transaction","detail":"{read_only:false; response_revision:4796; number_of_response:1; }","duration":"190.64869ms","start":"2026-05-19T18:53:19.278045Z","end":"2026-05-19T18:53:19.468693Z","steps":["trace[671776535] 'process raft request' (duration: 85.835458ms)","trace[671776535] 'compare' (duration: 104.380933ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:53:23.330913Z","caller":"traceutil/trace.go:171","msg":"trace[19962642] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"252.667021ms","start":"2026-05-19T18:53:23.078169Z","end":"2026-05-19T18:53:23.330836Z","steps":["trace[19962642] 'process raft request' (duration: 252.394906ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:32.291109Z","caller":"traceutil/trace.go:171","msg":"trace[1718040867] linearizableReadLoop","detail":"{readStateIndex:5150; appliedIndex:5149; }","duration":"315.282487ms","start":"2026-05-19T18:53:31.9758Z","end":"2026-05-19T18:53:32.291082Z","steps":["trace[1718040867] 'read index received' (duration: 314.997651ms)","trace[1718040867] 'applied index is now lower than readState.Index' (duration: 283.766µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:53:32.291258Z","caller":"traceutil/trace.go:171","msg":"trace[105604390] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"410.781519ms","start":"2026-05-19T18:53:31.880461Z","end":"2026-05-19T18:53:32.291242Z","steps":["trace[105604390] 'process raft request' (duration: 410.429952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:32.291413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:53:31.88045Z","time spent":"410.859381ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:53:32.291483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.158049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:53:32.291585Z","caller":"traceutil/trace.go:171","msg":"trace[1415087759] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:4965; }","duration":"244.310453ms","start":"2026-05-19T18:53:32.047245Z","end":"2026-05-19T18:53:32.291556Z","steps":["trace[1415087759] 'agreement among raft nodes before linearized reading' (duration: 244.142379ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:32.291626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.817948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:53:32.291631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.818287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-05-19T18:53:32.291708Z","caller":"traceutil/trace.go:171","msg":"trace[2138962459] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4965; }","duration":"315.92947ms","start":"2026-05-19T18:53:31.975745Z","end":"2026-05-19T18:53:32.291675Z","steps":["trace[2138962459] 'agreement among raft nodes before linearized reading' (duration: 315.809838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:32.29175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:53:31.975714Z","time spent":"316.025401ms","remote":"127.0.0.1:37736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-05-19T18:53:32.292348Z","caller":"traceutil/trace.go:171","msg":"trace[1877358382] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4965; }","duration":"214.939589ms","start":"2026-05-19T18:53:32.076742Z","end":"2026-05-19T18:53:32.291682Z","steps":["trace[1877358382] 'agreement among raft nodes before linearized reading' (duration: 214.744145ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:32.549296Z","caller":"traceutil/trace.go:171","msg":"trace[1002327711] linearizableReadLoop","detail":"{readStateIndex:5151; appliedIndex:5150; }","duration":"239.385053ms","start":"2026-05-19T18:53:32.309888Z","end":"2026-05-19T18:53:32.549274Z","steps":["trace[1002327711] 'read index received' (duration: 239.21212ms)","trace[1002327711] 'applied index is now lower than readState.Index' (duration: 171.903µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:53:32.549869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.953295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9635"} {"level":"info","ts":"2026-05-19T18:53:32.549961Z","caller":"traceutil/trace.go:171","msg":"trace[1435034646] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4966; }","duration":"240.055017ms","start":"2026-05-19T18:53:32.309884Z","end":"2026-05-19T18:53:32.549939Z","steps":["trace[1435034646] 'agreement among raft nodes before linearized reading' (duration: 239.754381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:32.550413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.605353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"warn","ts":"2026-05-19T18:53:32.55056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.847203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-19T18:53:32.550611Z","caller":"traceutil/trace.go:171","msg":"trace[242794597] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4967; }","duration":"142.946245ms","start":"2026-05-19T18:53:32.407652Z","end":"2026-05-19T18:53:32.550598Z","steps":["trace[242794597] 'agreement among raft nodes before linearized reading' (duration: 142.819343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:32.550623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.025402ms","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-05-19T18:53:32.550514Z","caller":"traceutil/trace.go:171","msg":"trace[1372044491] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4967; }","duration":"211.760696ms","start":"2026-05-19T18:53:32.338727Z","end":"2026-05-19T18:53:32.550488Z","steps":["trace[1372044491] 'agreement among raft nodes before linearized reading' (duration: 211.478041ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:32.550721Z","caller":"traceutil/trace.go:171","msg":"trace[975409799] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4967; }","duration":"118.173906ms","start":"2026-05-19T18:53:32.432528Z","end":"2026-05-19T18:53:32.550702Z","steps":["trace[975409799] 'agreement among raft nodes before linearized reading' (duration: 117.89996ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:32.550956Z","caller":"traceutil/trace.go:171","msg":"trace[1743084340] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"243.442465ms","start":"2026-05-19T18:53:32.307496Z","end":"2026-05-19T18:53:32.550939Z","steps":["trace[1743084340] 'process raft request' (duration: 241.571037ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:32.740055Z","caller":"traceutil/trace.go:171","msg":"trace[1103715862] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"108.94615ms","start":"2026-05-19T18:53:32.631079Z","end":"2026-05-19T18:53:32.740025Z","steps":["trace[1103715862] 'process raft request' (duration: 16.523904ms)","trace[1103715862] 'compare' (duration: 92.229951ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:53:32.74013Z","caller":"traceutil/trace.go:171","msg":"trace[1583703521] linearizableReadLoop","detail":"{readStateIndex:5155; appliedIndex:5154; }","duration":"109.00672ms","start":"2026-05-19T18:53:32.631113Z","end":"2026-05-19T18:53:32.740119Z","steps":["trace[1583703521] 'read index received' (duration: 20.21µs)","trace[1583703521] 'applied index is now lower than readState.Index' (duration: 108.98501ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:53:32.740066Z","caller":"traceutil/trace.go:171","msg":"trace[757794327] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"108.918719ms","start":"2026-05-19T18:53:32.631136Z","end":"2026-05-19T18:53:32.740055Z","steps":["trace[757794327] 'process raft request' (duration: 108.832146ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:32.740419Z","caller":"traceutil/trace.go:171","msg":"trace[391168444] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"109.205085ms","start":"2026-05-19T18:53:32.631204Z","end":"2026-05-19T18:53:32.740409Z","steps":["trace[391168444] 'process raft request' (duration: 108.820478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:32.740558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.42348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18b10c401b4882d6\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-05-19T18:53:32.740624Z","caller":"traceutil/trace.go:171","msg":"trace[1091571406] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18b10c401b4882d6; range_end:; response_count:1; response_revision:4972; }","duration":"109.527991ms","start":"2026-05-19T18:53:32.631083Z","end":"2026-05-19T18:53:32.740611Z","steps":["trace[1091571406] 'agreement among raft nodes before linearized reading' (duration: 109.096783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:53:32.740847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.326828ms","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-05-19T18:53:32.740878Z","caller":"traceutil/trace.go:171","msg":"trace[1657536049] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4974; }","duration":"109.374208ms","start":"2026-05-19T18:53:32.631495Z","end":"2026-05-19T18:53:32.740869Z","steps":["trace[1657536049] 'agreement among raft nodes before linearized reading' (duration: 109.277796ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:32.740953Z","caller":"traceutil/trace.go:171","msg":"trace[83152133] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"109.713965ms","start":"2026-05-19T18:53:32.631228Z","end":"2026-05-19T18:53:32.740942Z","steps":["trace[83152133] 'process raft request' (duration: 108.98416ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:53:32.740989Z","caller":"traceutil/trace.go:171","msg":"trace[1872680563] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"109.691564ms","start":"2026-05-19T18:53:32.631275Z","end":"2026-05-19T18:53:32.740967Z","steps":["trace[1872680563] 'process raft request' (duration: 109.45011ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:54:42.632087Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2901} {"level":"info","ts":"2026-05-19T18:54:42.69777Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2901,"took":"64.453151ms","hash":979411171,"current-db-size-bytes":53239808,"current-db-size":"53 MB","current-db-size-in-use-bytes":29536256,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-19T18:54:42.697829Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":979411171,"revision":2901,"compact-revision":-1} {"level":"info","ts":"2026-05-19T18:57:35.874234Z","caller":"traceutil/trace.go:171","msg":"trace[700268052] transaction","detail":"{read_only:false; response_revision:6748; number_of_response:1; }","duration":"144.759505ms","start":"2026-05-19T18:57:35.729451Z","end":"2026-05-19T18:57:35.87421Z","steps":["trace[700268052] 'process raft request' (duration: 144.605762ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:57:35.88142Z","caller":"traceutil/trace.go:171","msg":"trace[440524908] transaction","detail":"{read_only:false; response_revision:6749; number_of_response:1; }","duration":"151.638979ms","start":"2026-05-19T18:57:35.729763Z","end":"2026-05-19T18:57:35.881402Z","steps":["trace[440524908] 'process raft request' (duration: 151.308194ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:59:42.641562Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5561} {"level":"info","ts":"2026-05-19T18:59:42.720949Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5561,"took":"77.752739ms","hash":3948618272,"current-db-size-bytes":53239808,"current-db-size":"53 MB","current-db-size-in-use-bytes":18505728,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-19T18:59:42.721028Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3948618272,"revision":5561,"compact-revision":2901}