{"level":"warn","ts":"2026-10-19T01:52:30.665756Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-19T01:52:30.665869Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.128: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://162.253.55.128:2380","--initial-cluster=instance=https://162.253.55.128:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.128:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.128: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-10-19T01:52:30.665967Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-19T01:52:30.665983Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.128:2380"]} {"level":"info","ts":"2026-10-19T01:52:30.666012Z","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-10-19T01:52:30.666793Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.128:2379"]} {"level":"info","ts":"2026-10-19T01:52:30.666904Z","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://162.253.55.128:2380"],"listen-peer-urls":["https://162.253.55.128:2380"],"advertise-client-urls":["https://162.253.55.128:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.128:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.128: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-10-19T01:52:30.67038Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.138998ms"} {"level":"info","ts":"2026-10-19T01:52:30.676208Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3e8b7bea2e3a32b","cluster-id":"ca619600f96ab468"} {"level":"info","ts":"2026-10-19T01:52:30.676273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b switched to configuration voters=()"} {"level":"info","ts":"2026-10-19T01:52:30.676299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became follower at term 0"} {"level":"info","ts":"2026-10-19T01:52:30.676315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3e8b7bea2e3a32b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-19T01:52:30.676335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became follower at term 1"} {"level":"info","ts":"2026-10-19T01:52:30.676368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b switched to configuration voters=(16422578070611010347)"} {"level":"warn","ts":"2026-10-19T01:52:30.682191Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-19T01:52:30.684145Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-19T01:52:30.68611Z","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-10-19T01:52:30.68869Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3e8b7bea2e3a32b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-19T01:52:30.688875Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3e8b7bea2e3a32b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-19T01:52:30.688937Z","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-10-19T01:52:30.689144Z","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-10-19T01:52:30.68916Z","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-10-19T01:52:30.690484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b switched to configuration voters=(16422578070611010347)"} {"level":"info","ts":"2026-10-19T01:52:30.690915Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ca619600f96ab468","local-member-id":"e3e8b7bea2e3a32b","added-peer-id":"e3e8b7bea2e3a32b","added-peer-peer-urls":["https://162.253.55.128:2380"]} {"level":"info","ts":"2026-10-19T01:52:30.692391Z","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-10-19T01:52:30.692493Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.128:2380"} {"level":"info","ts":"2026-10-19T01:52:30.692531Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.128:2380"} {"level":"info","ts":"2026-10-19T01:52:30.692675Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3e8b7bea2e3a32b","initial-advertise-peer-urls":["https://162.253.55.128:2380"],"listen-peer-urls":["https://162.253.55.128:2380"],"advertise-client-urls":["https://162.253.55.128:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.128:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-19T01:52:30.692731Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-19T01:52:31.276915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b is starting a new election at term 1"} {"level":"info","ts":"2026-10-19T01:52:31.276983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became pre-candidate at term 1"} {"level":"info","ts":"2026-10-19T01:52:31.277033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b received MsgPreVoteResp from e3e8b7bea2e3a32b at term 1"} {"level":"info","ts":"2026-10-19T01:52:31.277051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became candidate at term 2"} {"level":"info","ts":"2026-10-19T01:52:31.277081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b received MsgVoteResp from e3e8b7bea2e3a32b at term 2"} {"level":"info","ts":"2026-10-19T01:52:31.277097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became leader at term 2"} {"level":"info","ts":"2026-10-19T01:52:31.277113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3e8b7bea2e3a32b elected leader e3e8b7bea2e3a32b at term 2"} {"level":"info","ts":"2026-10-19T01:52:31.279306Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3e8b7bea2e3a32b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.128:2379]}","request-path":"/0/members/e3e8b7bea2e3a32b/attributes","cluster-id":"ca619600f96ab468","publish-timeout":"7s"} {"level":"info","ts":"2026-10-19T01:52:31.279682Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:52:31.280901Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:52:31.281175Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:52:31.281264Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-19T01:52:31.281352Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-19T01:52:31.281619Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ca619600f96ab468","local-member-id":"e3e8b7bea2e3a32b","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:52:31.281815Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:52:31.281851Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:52:31.284609Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-19T01:52:31.284655Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.128:2379"} {"level":"info","ts":"2026-10-19T01:52:33.908711Z","caller":"traceutil/trace.go:171","msg":"trace[530802651] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"101.739035ms","start":"2026-10-19T01:52:33.806943Z","end":"2026-10-19T01:52:33.908682Z","steps":["trace[530802651] 'process raft request' (duration: 98.680988ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:52:46.958339Z","caller":"traceutil/trace.go:171","msg":"trace[556806453] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"107.961809ms","start":"2026-10-19T01:52:46.850335Z","end":"2026-10-19T01:52:46.958297Z","steps":["trace[556806453] 'process raft request' (duration: 107.703963ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:52:47.45925Z","caller":"traceutil/trace.go:171","msg":"trace[544512741] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:388; }","duration":"119.765085ms","start":"2026-10-19T01:52:47.33946Z","end":"2026-10-19T01:52:47.459225Z","steps":["trace[544512741] 'read index received' (duration: 119.601981ms)","trace[544512741] 'applied index is now lower than readState.Index' (duration: 161.654µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:52:47.459328Z","caller":"traceutil/trace.go:171","msg":"trace[208249795] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"303.562162ms","start":"2026-10-19T01:52:47.15574Z","end":"2026-10-19T01:52:47.459302Z","steps":["trace[208249795] 'process raft request' (duration: 303.346786ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:52:47.459374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.896467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:52:47.459449Z","caller":"traceutil/trace.go:171","msg":"trace[26671849] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:376; }","duration":"120.04154ms","start":"2026-10-19T01:52:47.339396Z","end":"2026-10-19T01:52:47.459437Z","steps":["trace[26671849] 'agreement among raft nodes before linearized reading' (duration: 119.917628ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:52:47.459967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:52:47.15572Z","time spent":"303.662734ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:53:16.999341Z","caller":"traceutil/trace.go:171","msg":"trace[25955548] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"101.462728ms","start":"2026-10-19T01:53:16.897858Z","end":"2026-10-19T01:53:16.999321Z","steps":["trace[25955548] 'process raft request' (duration: 101.188231ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.114196Z","caller":"traceutil/trace.go:171","msg":"trace[780863531] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"210.326081ms","start":"2026-10-19T01:53:16.903842Z","end":"2026-10-19T01:53:17.114168Z","steps":["trace[780863531] 'process raft request' (duration: 183.277734ms)","trace[780863531] 'compare' (duration: 26.75786ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:53:17.11435Z","caller":"traceutil/trace.go:171","msg":"trace[71630729] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"210.237179ms","start":"2026-10-19T01:53:16.904086Z","end":"2026-10-19T01:53:17.114323Z","steps":["trace[71630729] 'process raft request' (duration: 210.029724ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.114456Z","caller":"traceutil/trace.go:171","msg":"trace[1238268564] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"180.765482ms","start":"2026-10-19T01:53:16.933677Z","end":"2026-10-19T01:53:17.114442Z","steps":["trace[1238268564] 'process raft request' (duration: 180.583547ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.114866Z","caller":"traceutil/trace.go:171","msg":"trace[2074738058] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"179.851519ms","start":"2026-10-19T01:53:16.934976Z","end":"2026-10-19T01:53:17.114828Z","steps":["trace[2074738058] 'process raft request' (duration: 179.573772ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.114951Z","caller":"traceutil/trace.go:171","msg":"trace[1990762616] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"178.113057ms","start":"2026-10-19T01:53:16.936824Z","end":"2026-10-19T01:53:17.114937Z","steps":["trace[1990762616] 'process raft request' (duration: 177.84607ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.115108Z","caller":"traceutil/trace.go:171","msg":"trace[1739939392] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"176.447393ms","start":"2026-10-19T01:53:16.938644Z","end":"2026-10-19T01:53:17.115091Z","steps":["trace[1739939392] 'process raft request' (duration: 176.183247ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.115191Z","caller":"traceutil/trace.go:171","msg":"trace[19616160] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"176.485385ms","start":"2026-10-19T01:53:16.938693Z","end":"2026-10-19T01:53:17.115179Z","steps":["trace[19616160] 'process raft request' (duration: 176.200469ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.115264Z","caller":"traceutil/trace.go:171","msg":"trace[1127572455] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"175.49ms","start":"2026-10-19T01:53:16.939762Z","end":"2026-10-19T01:53:17.115252Z","steps":["trace[1127572455] 'process raft request' (duration: 175.307285ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.115566Z","caller":"traceutil/trace.go:171","msg":"trace[664027447] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"154.654977ms","start":"2026-10-19T01:53:16.960892Z","end":"2026-10-19T01:53:17.115547Z","steps":["trace[664027447] 'process raft request' (duration: 154.261127ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.115817Z","caller":"traceutil/trace.go:171","msg":"trace[2139561575] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"139.472689ms","start":"2026-10-19T01:53:16.976329Z","end":"2026-10-19T01:53:17.115801Z","steps":["trace[2139561575] 'process raft request' (duration: 139.15256ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.120348Z","caller":"traceutil/trace.go:171","msg":"trace[1236447800] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"113.87825ms","start":"2026-10-19T01:53:17.00645Z","end":"2026-10-19T01:53:17.120328Z","steps":["trace[1236447800] 'process raft request' (duration: 113.537301ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.121382Z","caller":"traceutil/trace.go:171","msg":"trace[804555421] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"112.134575ms","start":"2026-10-19T01:53:17.009211Z","end":"2026-10-19T01:53:17.121345Z","steps":["trace[804555421] 'process raft request' (duration: 110.905825ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:17.12186Z","caller":"traceutil/trace.go:171","msg":"trace[412050058] transaction","detail":"{read_only:false; number_of_response:1; response_revision:522; }","duration":"112.550916ms","start":"2026-10-19T01:53:17.009296Z","end":"2026-10-19T01:53:17.121847Z","steps":["trace[412050058] 'process raft request' (duration: 111.91329ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:53:24.452652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.560388ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:53:24.452793Z","caller":"traceutil/trace.go:171","msg":"trace[216963762] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"940.524865ms","start":"2026-10-19T01:53:23.512246Z","end":"2026-10-19T01:53:24.452771Z","steps":["trace[216963762] 'read index received' (duration: 276.193089ms)","trace[216963762] 'applied index is now lower than readState.Index' (duration: 664.330026ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:53:24.452848Z","caller":"traceutil/trace.go:171","msg":"trace[1114515499] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"967.823568ms","start":"2026-10-19T01:53:23.484978Z","end":"2026-10-19T01:53:24.452802Z","steps":["trace[1114515499] 'process raft request' (duration: 303.787369ms)","trace[1114515499] 'compare' (duration: 663.015614ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:53:24.452993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.7379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-42lfh\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-10-19T01:53:24.453008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:53:23.484943Z","time spent":"967.980462ms","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:53:24.45309Z","caller":"traceutil/trace.go:171","msg":"trace[2052553727] range","detail":"{range_begin:/registry/pods/kube-system/cilium-42lfh; range_end:; response_count:1; response_revision:617; }","duration":"940.816053ms","start":"2026-10-19T01:53:23.512217Z","end":"2026-10-19T01:53:24.453033Z","steps":["trace[2052553727] 'agreement among raft nodes before linearized reading' (duration: 940.645318ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:53:24.453147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:53:23.512203Z","time spent":"940.931715ms","remote":"127.0.0.1:47592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-42lfh\" "} {"level":"info","ts":"2026-10-19T01:53:24.464667Z","caller":"traceutil/trace.go:171","msg":"trace[442136905] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"273.991063ms","start":"2026-10-19T01:53:24.190611Z","end":"2026-10-19T01:53:24.464602Z","steps":["trace[442136905] 'process raft request' (duration: 273.788308ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:53:24.464744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.996689ms","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-10-19T01:53:24.464813Z","caller":"traceutil/trace.go:171","msg":"trace[1978594170] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"728.113042ms","start":"2026-10-19T01:53:23.73668Z","end":"2026-10-19T01:53:24.464793Z","steps":["trace[1978594170] 'agreement among raft nodes before linearized reading' (duration: 727.831835ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:53:24.464867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:53:23.736656Z","time spent":"728.198214ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-19T01:53:24.464837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.616842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:53:24.464941Z","caller":"traceutil/trace.go:171","msg":"trace[105306630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"125.734205ms","start":"2026-10-19T01:53:24.339184Z","end":"2026-10-19T01:53:24.464918Z","steps":["trace[105306630] 'agreement among raft nodes before linearized reading' (duration: 125.572281ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:12.248959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.741107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-10-19T01:54:12.249108Z","caller":"traceutil/trace.go:171","msg":"trace[1267780009] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1191; }","duration":"245.895471ms","start":"2026-10-19T01:54:12.003158Z","end":"2026-10-19T01:54:12.249053Z","steps":["trace[1267780009] 'range keys from in-memory index tree' (duration: 245.556312ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:12.249292Z","caller":"traceutil/trace.go:171","msg":"trace[1995280795] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"146.073763ms","start":"2026-10-19T01:54:12.103174Z","end":"2026-10-19T01:54:12.249247Z","steps":["trace[1995280795] 'process raft request' (duration: 142.549285ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:00.480928Z","caller":"traceutil/trace.go:171","msg":"trace[828558752] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"470.221668ms","start":"2026-10-19T01:55:00.010663Z","end":"2026-10-19T01:55:00.480885Z","steps":["trace[828558752] 'process raft request' (duration: 469.846708ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:00.481191Z","caller":"traceutil/trace.go:171","msg":"trace[239372263] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"470.464234ms","start":"2026-10-19T01:55:00.010675Z","end":"2026-10-19T01:55:00.48114Z","steps":["trace[239372263] 'process raft request' (duration: 470.152716ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:00.481263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:00.010646Z","time spent":"470.443303ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:55:00.481385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:00.010656Z","time spent":"470.620888ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:55:00.481448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.711244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-919dd3d2-cf9e-4244-aa3a-d16a79d15e80\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-19T01:55:00.481534Z","caller":"traceutil/trace.go:171","msg":"trace[1138196975] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-919dd3d2-cf9e-4244-aa3a-d16a79d15e80; range_end:; response_count:1; response_revision:1855; }","duration":"455.844047ms","start":"2026-10-19T01:55:00.025669Z","end":"2026-10-19T01:55:00.481513Z","steps":["trace[1138196975] 'agreement among raft nodes before linearized reading' (duration: 455.58875ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:00.481565Z","caller":"traceutil/trace.go:171","msg":"trace[949975710] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1927; }","duration":"455.386325ms","start":"2026-10-19T01:55:00.025707Z","end":"2026-10-19T01:55:00.481094Z","steps":["trace[949975710] 'read index received' (duration: 454.728138ms)","trace[949975710] 'applied index is now lower than readState.Index' (duration: 656.397µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:55:00.481589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:00.025654Z","time spent":"455.926269ms","remote":"127.0.0.1:47592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-919dd3d2-cf9e-4244-aa3a-d16a79d15e80\" "} {"level":"warn","ts":"2026-10-19T01:55:00.507688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.962142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-19T01:55:00.5077Z","caller":"traceutil/trace.go:171","msg":"trace[2122264967] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"429.20506ms","start":"2026-10-19T01:55:00.07847Z","end":"2026-10-19T01:55:00.507675Z","steps":["trace[2122264967] 'process raft request' (duration: 428.897863ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:00.507778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.166076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T01:55:00.507795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.381014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:00.507905Z","caller":"traceutil/trace.go:171","msg":"trace[1598569523] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1857; }","duration":"139.371751ms","start":"2026-10-19T01:55:00.368499Z","end":"2026-10-19T01:55:00.507871Z","steps":["trace[1598569523] 'agreement among raft nodes before linearized reading' (duration: 139.130865ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:00.507918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.308826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-919dd3d2-cf9e-4244-aa3a-d16a79d15e80\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-19T01:55:00.507938Z","caller":"traceutil/trace.go:171","msg":"trace[1902543525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1857; }","duration":"167.576629ms","start":"2026-10-19T01:55:00.340345Z","end":"2026-10-19T01:55:00.507922Z","steps":["trace[1902543525] 'agreement among raft nodes before linearized reading' (duration: 167.369433ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:00.507971Z","caller":"traceutil/trace.go:171","msg":"trace[1847624249] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-919dd3d2-cf9e-4244-aa3a-d16a79d15e80; range_end:; response_count:1; response_revision:1857; }","duration":"174.403869ms","start":"2026-10-19T01:55:00.333552Z","end":"2026-10-19T01:55:00.507955Z","steps":["trace[1847624249] 'agreement among raft nodes before linearized reading' (duration: 174.260285ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:00.508002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:00.078437Z","time spent":"429.341444ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:55:00.508283Z","caller":"traceutil/trace.go:171","msg":"trace[438515987] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1857; }","duration":"381.043274ms","start":"2026-10-19T01:55:00.1267Z","end":"2026-10-19T01:55:00.507743Z","steps":["trace[438515987] 'agreement among raft nodes before linearized reading' (duration: 380.86505ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:00.50854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:00.126655Z","time spent":"381.866354ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-10-19T01:55:00.685976Z","caller":"traceutil/trace.go:171","msg":"trace[494051566] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1931; }","duration":"175.953517ms","start":"2026-10-19T01:55:00.509995Z","end":"2026-10-19T01:55:00.685948Z","steps":["trace[494051566] 'read index received' (duration: 175.827234ms)","trace[494051566] 'applied index is now lower than readState.Index' (duration: 124.543µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:00.686061Z","caller":"traceutil/trace.go:171","msg":"trace[1485933771] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"195.862236ms","start":"2026-10-19T01:55:00.490146Z","end":"2026-10-19T01:55:00.686008Z","steps":["trace[1485933771] 'process raft request' (duration: 195.606199ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:00.686132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.112091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:00.686173Z","caller":"traceutil/trace.go:171","msg":"trace[1187833256] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1858; }","duration":"176.217333ms","start":"2026-10-19T01:55:00.509942Z","end":"2026-10-19T01:55:00.68616Z","steps":["trace[1187833256] 'agreement among raft nodes before linearized reading' (duration: 176.131631ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:00.700658Z","caller":"traceutil/trace.go:171","msg":"trace[217198640] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"186.704277ms","start":"2026-10-19T01:55:00.513924Z","end":"2026-10-19T01:55:00.700629Z","steps":["trace[217198640] 'process raft request' (duration: 186.540873ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:01.031903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.907784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:55:01.032015Z","caller":"traceutil/trace.go:171","msg":"trace[816609032] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"326.651011ms","start":"2026-10-19T01:55:00.705344Z","end":"2026-10-19T01:55:01.031995Z","steps":["trace[816609032] 'process raft request' (duration: 69.553772ms)","trace[816609032] 'compare' (duration: 256.745781ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:55:01.032079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:00.705321Z","time spent":"326.723783ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:55:01.036306Z","caller":"traceutil/trace.go:171","msg":"trace[1627699922] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"173.635189ms","start":"2026-10-19T01:55:00.862646Z","end":"2026-10-19T01:55:01.036281Z","steps":["trace[1627699922] 'process raft request' (duration: 173.479645ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:09.473698Z","caller":"traceutil/trace.go:171","msg":"trace[650356733] linearizableReadLoop","detail":"{readStateIndex:2019; appliedIndex:2018; }","duration":"134.325735ms","start":"2026-10-19T01:55:09.339345Z","end":"2026-10-19T01:55:09.473671Z","steps":["trace[650356733] 'read index received' (duration: 134.105979ms)","trace[650356733] 'applied index is now lower than readState.Index' (duration: 218.586µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:09.473867Z","caller":"traceutil/trace.go:171","msg":"trace[287385095] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"196.727448ms","start":"2026-10-19T01:55:09.277103Z","end":"2026-10-19T01:55:09.473831Z","steps":["trace[287385095] 'process raft request' (duration: 196.42564ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:09.47393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.572361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:09.47398Z","caller":"traceutil/trace.go:171","msg":"trace[1002431602] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1944; }","duration":"134.660063ms","start":"2026-10-19T01:55:09.339305Z","end":"2026-10-19T01:55:09.473965Z","steps":["trace[1002431602] 'agreement among raft nodes before linearized reading' (duration: 134.571691ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:55:45.952737Z","caller":"traceutil/trace.go:171","msg":"trace[2013554737] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"164.367092ms","start":"2026-10-19T01:55:45.788329Z","end":"2026-10-19T01:55:45.952696Z","steps":["trace[2013554737] 'process raft request' (duration: 144.063622ms)","trace[2013554737] 'compare' (duration: 20.078434ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:55:46.566963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.423412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:55:46.567072Z","caller":"traceutil/trace.go:171","msg":"trace[748743446] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2244; }","duration":"227.704068ms","start":"2026-10-19T01:55:46.339351Z","end":"2026-10-19T01:55:46.567055Z","steps":["trace[748743446] 'read index received' (duration: 52.771µs)","trace[748743446] 'applied index is now lower than readState.Index' (duration: 227.650027ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:55:46.56725Z","caller":"traceutil/trace.go:171","msg":"trace[1373571511] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"490.497989ms","start":"2026-10-19T01:55:46.076707Z","end":"2026-10-19T01:55:46.567205Z","steps":["trace[1373571511] 'process raft request' (duration: 207.743849ms)","trace[1373571511] 'compare' (duration: 281.988892ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:55:46.567442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:55:46.076672Z","time spent":"490.660433ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:55:46.567515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.955743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:46.567609Z","caller":"traceutil/trace.go:171","msg":"trace[581530189] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:2161; }","duration":"200.105657ms","start":"2026-10-19T01:55:46.367478Z","end":"2026-10-19T01:55:46.567583Z","steps":["trace[581530189] 'agreement among raft nodes before linearized reading' (duration: 199.881951ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:55:46.567717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.299744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:55:46.567864Z","caller":"traceutil/trace.go:171","msg":"trace[836793674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2161; }","duration":"228.461468ms","start":"2026-10-19T01:55:46.339298Z","end":"2026-10-19T01:55:46.567759Z","steps":["trace[836793674] 'agreement among raft nodes before linearized reading' (duration: 227.939495ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:57:14.914329Z","caller":"traceutil/trace.go:171","msg":"trace[763514875] linearizableReadLoop","detail":"{readStateIndex:2943; appliedIndex:2942; }","duration":"151.819892ms","start":"2026-10-19T01:57:14.762483Z","end":"2026-10-19T01:57:14.914303Z","steps":["trace[763514875] 'read index received' (duration: 124.346163ms)","trace[763514875] 'applied index is now lower than readState.Index' (duration: 27.472729ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:57:14.9146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.286396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:57:14.914665Z","caller":"traceutil/trace.go:171","msg":"trace[1143319727] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2832; }","duration":"121.410829ms","start":"2026-10-19T01:57:14.793236Z","end":"2026-10-19T01:57:14.914647Z","steps":["trace[1143319727] 'agreement among raft nodes before linearized reading' (duration: 121.243995ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:57:14.914583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.082248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:57:14.914756Z","caller":"traceutil/trace.go:171","msg":"trace[223718986] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:2832; }","duration":"152.276543ms","start":"2026-10-19T01:57:14.762425Z","end":"2026-10-19T01:57:14.914702Z","steps":["trace[223718986] 'agreement among raft nodes before linearized reading' (duration: 152.028367ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:57:14.914381Z","caller":"traceutil/trace.go:171","msg":"trace[1759340276] transaction","detail":"{read_only:false; response_revision:2832; number_of_response:1; }","duration":"180.375807ms","start":"2026-10-19T01:57:14.733969Z","end":"2026-10-19T01:57:14.914345Z","steps":["trace[1759340276] 'process raft request' (duration: 152.940789ms)","trace[1759340276] 'compare' (duration: 27.263883ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:00:28.864139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.704384ms","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-10-19T02:00:28.864237Z","caller":"traceutil/trace.go:171","msg":"trace[1192127062] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4053; }","duration":"327.848968ms","start":"2026-10-19T02:00:28.536366Z","end":"2026-10-19T02:00:28.864215Z","steps":["trace[1192127062] 'range keys from in-memory index tree' (duration: 327.476228ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:00:28.864426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:00:28.536345Z","time spent":"328.068743ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-19T02:00:28.864562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.027861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-19T02:00:28.864668Z","caller":"traceutil/trace.go:171","msg":"trace[968879245] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4053; }","duration":"106.170455ms","start":"2026-10-19T02:00:28.758473Z","end":"2026-10-19T02:00:28.864643Z","steps":["trace[968879245] 'range keys from in-memory index tree' (duration: 105.433576ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:01:59.806548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.291862ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:01:59.806696Z","caller":"traceutil/trace.go:171","msg":"trace[612627988] linearizableReadLoop","detail":"{readStateIndex:5468; appliedIndex:5467; }","duration":"279.87604ms","start":"2026-10-19T02:01:59.5268Z","end":"2026-10-19T02:01:59.806676Z","steps":["trace[612627988] 'read index received' (duration: 111.331811ms)","trace[612627988] 'applied index is now lower than readState.Index' (duration: 168.542619ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:01:59.806774Z","caller":"traceutil/trace.go:171","msg":"trace[1965061590] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"345.582512ms","start":"2026-10-19T02:01:59.461127Z","end":"2026-10-19T02:01:59.80671Z","steps":["trace[1965061590] 'process raft request' (duration: 176.998552ms)","trace[1965061590] 'compare' (duration: 168.129367ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:01:59.806862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.056785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2f37b9f-8488-4941-97c2-e9b636339220\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-19T02:01:59.806904Z","caller":"traceutil/trace.go:171","msg":"trace[1962557310] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c2f37b9f-8488-4941-97c2-e9b636339220; range_end:; response_count:1; response_revision:5266; }","duration":"280.140507ms","start":"2026-10-19T02:01:59.52675Z","end":"2026-10-19T02:01:59.806891Z","steps":["trace[1962557310] 'agreement among raft nodes before linearized reading' (duration: 279.977323ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:01:59.806932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:01:59.461106Z","time spent":"345.740886ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:02:01.507697Z","caller":"traceutil/trace.go:171","msg":"trace[1425227607] linearizableReadLoop","detail":"{readStateIndex:5494; appliedIndex:5493; }","duration":"107.067964ms","start":"2026-10-19T02:02:01.400606Z","end":"2026-10-19T02:02:01.507673Z","steps":["trace[1425227607] 'read index received' (duration: 106.865228ms)","trace[1425227607] 'applied index is now lower than readState.Index' (duration: 201.736µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:02:01.507816Z","caller":"traceutil/trace.go:171","msg":"trace[521650339] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"169.637929ms","start":"2026-10-19T02:02:01.338153Z","end":"2026-10-19T02:02:01.507791Z","steps":["trace[521650339] 'process raft request' (duration: 169.390182ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:01.507987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.34324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-19T02:02:01.508026Z","caller":"traceutil/trace.go:171","msg":"trace[688962415] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5290; }","duration":"107.457934ms","start":"2026-10-19T02:02:01.400558Z","end":"2026-10-19T02:02:01.508016Z","steps":["trace[688962415] 'agreement among raft nodes before linearized reading' (duration: 107.241259ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:02:01.631704Z","caller":"traceutil/trace.go:171","msg":"trace[57956540] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"120.218466ms","start":"2026-10-19T02:02:01.511411Z","end":"2026-10-19T02:02:01.631629Z","steps":["trace[57956540] 'process raft request' (duration: 94.129817ms)","trace[57956540] 'compare' (duration: 25.614266ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:02:01.654748Z","caller":"traceutil/trace.go:171","msg":"trace[1115074553] transaction","detail":"{read_only:false; response_revision:5292; number_of_response:1; }","duration":"143.210071ms","start":"2026-10-19T02:02:01.511509Z","end":"2026-10-19T02:02:01.654719Z","steps":["trace[1115074553] 'process raft request' (duration: 143.013215ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:02:01.654784Z","caller":"traceutil/trace.go:171","msg":"trace[1835634888] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"142.311305ms","start":"2026-10-19T02:02:01.512438Z","end":"2026-10-19T02:02:01.654749Z","steps":["trace[1835634888] 'process raft request' (duration: 142.182482ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:02:01.654903Z","caller":"traceutil/trace.go:171","msg":"trace[2125902743] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"137.437161ms","start":"2026-10-19T02:02:01.517434Z","end":"2026-10-19T02:02:01.654871Z","steps":["trace[2125902743] 'process raft request' (duration: 137.223525ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:15.089494Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11757668625140287011,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-19T02:02:15.159542Z","caller":"traceutil/trace.go:171","msg":"trace[1592055492] transaction","detail":"{read_only:false; response_revision:5533; number_of_response:1; }","duration":"788.796617ms","start":"2026-10-19T02:02:14.370716Z","end":"2026-10-19T02:02:15.159513Z","steps":["trace[1592055492] 'process raft request' (duration: 788.617762ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:15.159689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:02:14.370695Z","time spent":"788.92268ms","remote":"127.0.0.1:47672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1409,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:02:15.189714Z","caller":"traceutil/trace.go:171","msg":"trace[1103135905] transaction","detail":"{read_only:false; response_revision:5534; number_of_response:1; }","duration":"783.049318ms","start":"2026-10-19T02:02:14.406633Z","end":"2026-10-19T02:02:15.189682Z","steps":["trace[1103135905] 'process raft request' (duration: 782.769461ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:02:15.190284Z","caller":"traceutil/trace.go:171","msg":"trace[48671103] transaction","detail":"{read_only:false; response_revision:5537; number_of_response:1; }","duration":"782.156233ms","start":"2026-10-19T02:02:14.4081Z","end":"2026-10-19T02:02:15.190256Z","steps":["trace[48671103] 'process raft request' (duration: 782.013769ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:15.190356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.840851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:02:15.190201Z","caller":"traceutil/trace.go:171","msg":"trace[1877470168] linearizableReadLoop","detail":"{readStateIndex:5750; appliedIndex:5745; }","duration":"601.702456ms","start":"2026-10-19T02:02:14.588476Z","end":"2026-10-19T02:02:15.190178Z","steps":["trace[1877470168] 'read index received' (duration: 570.898967ms)","trace[1877470168] 'applied index is now lower than readState.Index' (duration: 30.802539ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:02:15.190408Z","caller":"traceutil/trace.go:171","msg":"trace[2121726031] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:5537; }","duration":"601.945303ms","start":"2026-10-19T02:02:14.588447Z","end":"2026-10-19T02:02:15.190392Z","steps":["trace[2121726031] 'agreement among raft nodes before linearized reading' (duration: 601.83411ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:15.190441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:02:14.58843Z","time spent":"602.002165ms","remote":"127.0.0.1:48292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:02:15.190455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:02:14.408095Z","time spent":"782.269306ms","remote":"127.0.0.1:47672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1067,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:02:15.190162Z","caller":"traceutil/trace.go:171","msg":"trace[2106585280] transaction","detail":"{read_only:false; response_revision:5535; number_of_response:1; }","duration":"783.45789ms","start":"2026-10-19T02:02:14.406672Z","end":"2026-10-19T02:02:15.19013Z","steps":["trace[2106585280] 'process raft request' (duration: 782.928765ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:15.190558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:02:14.406653Z","time spent":"783.864481ms","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:02:15.190624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.608706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.128\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-19T02:02:15.190705Z","caller":"traceutil/trace.go:171","msg":"trace[1705820205] range","detail":"{range_begin:/registry/masterleases/162.253.55.128; range_end:; response_count:1; response_revision:5537; }","duration":"501.731669ms","start":"2026-10-19T02:02:14.688955Z","end":"2026-10-19T02:02:15.190686Z","steps":["trace[1705820205] 'agreement among raft nodes before linearized reading' (duration: 501.522684ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:02:15.190206Z","caller":"traceutil/trace.go:171","msg":"trace[861323533] transaction","detail":"{read_only:false; response_revision:5536; number_of_response:1; }","duration":"783.148821ms","start":"2026-10-19T02:02:14.407034Z","end":"2026-10-19T02:02:15.190183Z","steps":["trace[861323533] 'process raft request' (duration: 782.856233ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:15.190747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:02:14.688934Z","time spent":"501.804872ms","remote":"127.0.0.1:47456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.128\" "} {"level":"warn","ts":"2026-10-19T02:02:15.190752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.586398ms","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-10-19T02:02:15.190819Z","caller":"traceutil/trace.go:171","msg":"trace[1581609503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5537; }","duration":"276.682832ms","start":"2026-10-19T02:02:14.914121Z","end":"2026-10-19T02:02:15.190804Z","steps":["trace[1581609503] 'agreement among raft nodes before linearized reading' (duration: 276.466186ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:15.190829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:02:14.407027Z","time spent":"783.757178ms","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":681,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:02:15.19084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.641388ms","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-10-19T02:02:15.190874Z","caller":"traceutil/trace.go:171","msg":"trace[238719289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5537; }","duration":"277.70974ms","start":"2026-10-19T02:02:14.913156Z","end":"2026-10-19T02:02:15.190866Z","steps":["trace[238719289] 'agreement among raft nodes before linearized reading' (duration: 277.583407ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:15.190458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:02:14.406613Z","time spent":"783.677996ms","remote":"127.0.0.1:47672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1193,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:02:23.664378Z","caller":"traceutil/trace.go:171","msg":"trace[1516981068] transaction","detail":"{read_only:false; response_revision:5697; number_of_response:1; }","duration":"170.437371ms","start":"2026-10-19T02:02:23.493913Z","end":"2026-10-19T02:02:23.66435Z","steps":["trace[1516981068] 'process raft request' (duration: 170.270076ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:23.916765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.316828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:02:23.916879Z","caller":"traceutil/trace.go:171","msg":"trace[1819586525] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:5697; }","duration":"149.496223ms","start":"2026-10-19T02:02:23.767357Z","end":"2026-10-19T02:02:23.916853Z","steps":["trace[1819586525] 'count revisions from in-memory index tree' (duration: 149.210526ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:23.917216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.466644ms","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-10-19T02:02:23.917313Z","caller":"traceutil/trace.go:171","msg":"trace[1140728648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5697; }","duration":"119.579808ms","start":"2026-10-19T02:02:23.79771Z","end":"2026-10-19T02:02:23.91729Z","steps":["trace[1140728648] 'range keys from in-memory index tree' (duration: 119.055434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:23.91742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.482159ms","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":"warn","ts":"2026-10-19T02:02:23.917499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.952431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-19T02:02:23.917552Z","caller":"traceutil/trace.go:171","msg":"trace[251661516] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5697; }","duration":"119.032833ms","start":"2026-10-19T02:02:23.798506Z","end":"2026-10-19T02:02:23.917539Z","steps":["trace[251661516] 'range keys from in-memory index tree' (duration: 118.777066ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:02:23.917548Z","caller":"traceutil/trace.go:171","msg":"trace[1345046312] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5697; }","duration":"167.653424ms","start":"2026-10-19T02:02:23.749869Z","end":"2026-10-19T02:02:23.917522Z","steps":["trace[1345046312] 'range keys from in-memory index tree' (duration: 167.301064ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:24.257149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.910382ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:02:24.257361Z","caller":"traceutil/trace.go:171","msg":"trace[1935436964] linearizableReadLoop","detail":"{readStateIndex:5919; appliedIndex:5916; }","duration":"228.796061ms","start":"2026-10-19T02:02:24.028549Z","end":"2026-10-19T02:02:24.257345Z","steps":["trace[1935436964] 'read index received' (duration: 85.465258ms)","trace[1935436964] 'applied index is now lower than readState.Index' (duration: 143.329863ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:02:24.257439Z","caller":"traceutil/trace.go:171","msg":"trace[823418016] transaction","detail":"{read_only:false; response_revision:5700; number_of_response:1; }","duration":"335.161544ms","start":"2026-10-19T02:02:23.922269Z","end":"2026-10-19T02:02:24.25743Z","steps":["trace[823418016] 'process raft request' (duration: 334.972699ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:24.257495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:02:23.922254Z","time spent":"335.206106ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:02:24.257615Z","caller":"traceutil/trace.go:171","msg":"trace[561072583] transaction","detail":"{read_only:false; response_revision:5699; number_of_response:1; }","duration":"335.906305ms","start":"2026-10-19T02:02:23.921669Z","end":"2026-10-19T02:02:24.257576Z","steps":["trace[561072583] 'process raft request' (duration: 192.450969ms)","trace[561072583] 'compare' (duration: 142.797929ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:02:24.257708Z","caller":"traceutil/trace.go:171","msg":"trace[427216833] transaction","detail":"{read_only:false; response_revision:5701; number_of_response:1; }","duration":"335.267728ms","start":"2026-10-19T02:02:23.922427Z","end":"2026-10-19T02:02:24.257695Z","steps":["trace[427216833] 'process raft request' (duration: 334.865276ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:24.257759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:02:23.922394Z","time spent":"335.33756ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:02:24.257799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:02:23.921645Z","time spent":"336.05432ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:02:24.257919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.59671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5ctrj\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-10-19T02:02:24.25795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.405927ms","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-10-19T02:02:24.257985Z","caller":"traceutil/trace.go:171","msg":"trace[634232282] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5ctrj; range_end:; response_count:1; response_revision:5701; }","duration":"168.716574ms","start":"2026-10-19T02:02:24.089252Z","end":"2026-10-19T02:02:24.257968Z","steps":["trace[634232282] 'agreement among raft nodes before linearized reading' (duration: 168.513859ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:02:24.258008Z","caller":"traceutil/trace.go:171","msg":"trace[1296527515] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5701; }","duration":"229.50049ms","start":"2026-10-19T02:02:24.028491Z","end":"2026-10-19T02:02:24.257991Z","steps":["trace[1296527515] 'agreement among raft nodes before linearized reading' (duration: 229.323715ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:02:24.258185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.259387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12429"} {"level":"info","ts":"2026-10-19T02:02:24.258233Z","caller":"traceutil/trace.go:171","msg":"trace[595308862] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5701; }","duration":"149.34991ms","start":"2026-10-19T02:02:24.108869Z","end":"2026-10-19T02:02:24.258219Z","steps":["trace[595308862] 'agreement among raft nodes before linearized reading' (duration: 149.212446ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:02:31.311768Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2922} {"level":"info","ts":"2026-10-19T02:02:31.391785Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2922,"took":"78.5386ms","hash":872791913,"current-db-size-bytes":56287232,"current-db-size":"56 MB","current-db-size-in-use-bytes":32165888,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T02:02:31.391849Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":872791913,"revision":2922,"compact-revision":-1} {"level":"info","ts":"2026-10-19T02:02:34.833804Z","caller":"traceutil/trace.go:171","msg":"trace[473772066] transaction","detail":"{read_only:false; response_revision:5852; number_of_response:1; }","duration":"122.105003ms","start":"2026-10-19T02:02:34.711658Z","end":"2026-10-19T02:02:34.833763Z","steps":["trace[473772066] 'process raft request' (duration: 121.782566ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:31.319697Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5824} {"level":"info","ts":"2026-10-19T02:07:31.410915Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5824,"took":"89.440731ms","hash":1538317154,"current-db-size-bytes":56287232,"current-db-size":"56 MB","current-db-size-in-use-bytes":26742784,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-19T02:07:31.410985Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1538317154,"revision":5824,"compact-revision":2922} {"level":"info","ts":"2026-10-19T02:08:28.150551Z","caller":"traceutil/trace.go:171","msg":"trace[290085919] transaction","detail":"{read_only:false; response_revision:8531; number_of_response:1; }","duration":"337.507874ms","start":"2026-10-19T02:08:27.813019Z","end":"2026-10-19T02:08:28.150527Z","steps":["trace[290085919] 'process raft request' (duration: 337.36296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:08:28.150724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:08:27.812981Z","time spent":"337.649288ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:08:28.380034Z","caller":"traceutil/trace.go:171","msg":"trace[1869327227] linearizableReadLoop","detail":"{readStateIndex:8839; appliedIndex:8838; }","duration":"188.631454ms","start":"2026-10-19T02:08:28.191365Z","end":"2026-10-19T02:08:28.379997Z","steps":["trace[1869327227] 'read index received' (duration: 187.227459ms)","trace[1869327227] 'applied index is now lower than readState.Index' (duration: 1.401995ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:08:28.380208Z","caller":"traceutil/trace.go:171","msg":"trace[229366727] transaction","detail":"{read_only:false; response_revision:8532; number_of_response:1; }","duration":"558.952038ms","start":"2026-10-19T02:08:27.821242Z","end":"2026-10-19T02:08:28.380194Z","steps":["trace[229366727] 'process raft request' (duration: 557.4326ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:08:28.380367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:08:27.821224Z","time spent":"559.018089ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:08:28.38053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.08255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-10-19T02:08:28.380555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.109886ms","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-10-19T02:08:28.380632Z","caller":"traceutil/trace.go:171","msg":"trace[1473552357] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8532; }","duration":"176.220354ms","start":"2026-10-19T02:08:28.20439Z","end":"2026-10-19T02:08:28.38061Z","steps":["trace[1473552357] 'agreement among raft nodes before linearized reading' (duration: 175.961217ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:08:28.380642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.66581ms","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-10-19T02:08:28.380693Z","caller":"traceutil/trace.go:171","msg":"trace[1253846724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8532; }","duration":"189.356912ms","start":"2026-10-19T02:08:28.191314Z","end":"2026-10-19T02:08:28.380671Z","steps":["trace[1253846724] 'agreement among raft nodes before linearized reading' (duration: 189.028074ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:08:28.3807Z","caller":"traceutil/trace.go:171","msg":"trace[1188069416] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8532; }","duration":"135.756863ms","start":"2026-10-19T02:08:28.244929Z","end":"2026-10-19T02:08:28.380686Z","steps":["trace[1188069416] 'agreement among raft nodes before linearized reading' (duration: 135.571918ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:08:40.702815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.204379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:08:40.70295Z","caller":"traceutil/trace.go:171","msg":"trace[1003841132] transaction","detail":"{read_only:false; response_revision:8597; number_of_response:1; }","duration":"196.862599ms","start":"2026-10-19T02:08:40.506059Z","end":"2026-10-19T02:08:40.702922Z","steps":["trace[1003841132] 'process raft request' (duration: 95.461135ms)","trace[1003841132] 'compare' (duration: 101.076286ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:08:40.751329Z","caller":"traceutil/trace.go:171","msg":"trace[1675825000] transaction","detail":"{read_only:false; response_revision:8599; number_of_response:1; }","duration":"244.157181ms","start":"2026-10-19T02:08:40.507159Z","end":"2026-10-19T02:08:40.751317Z","steps":["trace[1675825000] 'process raft request' (duration: 243.889094ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:08:40.751527Z","caller":"traceutil/trace.go:171","msg":"trace[35672230] linearizableReadLoop","detail":"{readStateIndex:8911; appliedIndex:8908; }","duration":"119.62706ms","start":"2026-10-19T02:08:40.631872Z","end":"2026-10-19T02:08:40.751499Z","steps":["trace[35672230] 'read index received' (duration: 118.992284ms)","trace[35672230] 'applied index is now lower than readState.Index' (duration: 633.616µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:08:40.751578Z","caller":"traceutil/trace.go:171","msg":"trace[434380612] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"244.396427ms","start":"2026-10-19T02:08:40.507171Z","end":"2026-10-19T02:08:40.751567Z","steps":["trace[434380612] 'process raft request' (duration: 244.075969ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:08:40.75117Z","caller":"traceutil/trace.go:171","msg":"trace[1690116840] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"244.018128ms","start":"2026-10-19T02:08:40.507102Z","end":"2026-10-19T02:08:40.75112Z","steps":["trace[1690116840] 'process raft request' (duration: 243.821673ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:08:40.751715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.827935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5ctrj\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-19T02:08:40.751748Z","caller":"traceutil/trace.go:171","msg":"trace[425094899] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5ctrj; range_end:; response_count:1; response_revision:8600; }","duration":"119.899497ms","start":"2026-10-19T02:08:40.631838Z","end":"2026-10-19T02:08:40.751737Z","steps":["trace[425094899] 'agreement among raft nodes before linearized reading' (duration: 119.756433ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:09:08.965609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.478986ms","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-10-19T02:09:08.965684Z","caller":"traceutil/trace.go:171","msg":"trace[1635617670] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8803; }","duration":"119.60156ms","start":"2026-10-19T02:09:08.84607Z","end":"2026-10-19T02:09:08.965672Z","steps":["trace[1635617670] 'range keys from in-memory index tree' (duration: 119.381384ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:09:10.763324Z","caller":"traceutil/trace.go:171","msg":"trace[1909134029] transaction","detail":"{read_only:false; response_revision:8813; number_of_response:1; }","duration":"110.470731ms","start":"2026-10-19T02:09:10.652823Z","end":"2026-10-19T02:09:10.763294Z","steps":["trace[1909134029] 'process raft request' (duration: 58.778699ms)","trace[1909134029] 'compare' (duration: 51.468626ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:09:16.96318Z","caller":"traceutil/trace.go:171","msg":"trace[64346609] transaction","detail":"{read_only:false; response_revision:8846; number_of_response:1; }","duration":"153.593108ms","start":"2026-10-19T02:09:16.80956Z","end":"2026-10-19T02:09:16.963154Z","steps":["trace[64346609] 'process raft request' (duration: 153.451374ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:09:24.309402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.242324ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:09:24.309504Z","caller":"traceutil/trace.go:171","msg":"trace[1873134381] linearizableReadLoop","detail":"{readStateIndex:9246; appliedIndex:9245; }","duration":"279.823502ms","start":"2026-10-19T02:09:24.029666Z","end":"2026-10-19T02:09:24.309489Z","steps":["trace[1873134381] 'read index received' (duration: 79.381082ms)","trace[1873134381] 'applied index is now lower than readState.Index' (duration: 200.44096ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:09:24.309525Z","caller":"traceutil/trace.go:171","msg":"trace[597189464] transaction","detail":"{read_only:false; response_revision:8922; number_of_response:1; }","duration":"299.231147ms","start":"2026-10-19T02:09:24.010263Z","end":"2026-10-19T02:09:24.309494Z","steps":["trace[597189464] 'process raft request' (duration: 98.792218ms)","trace[597189464] 'compare' (duration: 199.956797ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:09:24.309619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.951116ms","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-10-19T02:09:24.309649Z","caller":"traceutil/trace.go:171","msg":"trace[1848113047] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:8922; }","duration":"280.014217ms","start":"2026-10-19T02:09:24.029624Z","end":"2026-10-19T02:09:24.309638Z","steps":["trace[1848113047] 'agreement among raft nodes before linearized reading' (duration: 279.949285ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:09:24.309689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.407123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-b5nnj\" ","response":"range_response_count:1 size:4813"} {"level":"info","ts":"2026-10-19T02:09:24.309764Z","caller":"traceutil/trace.go:171","msg":"trace[952368975] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-b5nnj; range_end:; response_count:1; response_revision:8922; }","duration":"251.517185ms","start":"2026-10-19T02:09:24.058228Z","end":"2026-10-19T02:09:24.309745Z","steps":["trace[952368975] 'agreement among raft nodes before linearized reading' (duration: 251.398662ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:09:24.44211Z","caller":"traceutil/trace.go:171","msg":"trace[1680273215] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8924; }","duration":"116.587543ms","start":"2026-10-19T02:09:24.325502Z","end":"2026-10-19T02:09:24.44209Z","steps":["trace[1680273215] 'process raft request' (duration: 116.470561ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:09:24.442095Z","caller":"traceutil/trace.go:171","msg":"trace[1873822902] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8924; }","duration":"119.069275ms","start":"2026-10-19T02:09:24.322991Z","end":"2026-10-19T02:09:24.44206Z","steps":["trace[1873822902] 'process raft request' (duration: 107.783954ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:09:24.868162Z","caller":"traceutil/trace.go:171","msg":"trace[497176694] linearizableReadLoop","detail":"{readStateIndex:9252; appliedIndex:9251; }","duration":"130.658595ms","start":"2026-10-19T02:09:24.737475Z","end":"2026-10-19T02:09:24.868133Z","steps":["trace[497176694] 'read index received' (duration: 130.49018ms)","trace[497176694] 'applied index is now lower than readState.Index' (duration: 166.965µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:09:24.868358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.86709ms","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-10-19T02:09:24.868411Z","caller":"traceutil/trace.go:171","msg":"trace[836297443] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8926; }","duration":"130.982893ms","start":"2026-10-19T02:09:24.73741Z","end":"2026-10-19T02:09:24.868393Z","steps":["trace[836297443] 'agreement among raft nodes before linearized reading' (duration: 130.834549ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:09:25.108433Z","caller":"traceutil/trace.go:171","msg":"trace[1890661467] transaction","detail":"{read_only:false; response_revision:8928; number_of_response:1; }","duration":"173.585677ms","start":"2026-10-19T02:09:24.934822Z","end":"2026-10-19T02:09:25.108408Z","steps":["trace[1890661467] 'process raft request' (duration: 78.683256ms)","trace[1890661467] 'compare' (duration: 94.462701ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:09:25.10888Z","caller":"traceutil/trace.go:171","msg":"trace[1941854093] transaction","detail":"{read_only:false; response_revision:8930; number_of_response:1; }","duration":"109.21998ms","start":"2026-10-19T02:09:24.999636Z","end":"2026-10-19T02:09:25.108856Z","steps":["trace[1941854093] 'process raft request' (duration: 109.037995ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:09:25.109311Z","caller":"traceutil/trace.go:171","msg":"trace[1799296054] transaction","detail":"{read_only:false; response_revision:8931; number_of_response:1; }","duration":"101.483086ms","start":"2026-10-19T02:09:25.007815Z","end":"2026-10-19T02:09:25.109298Z","steps":["trace[1799296054] 'process raft request' (duration: 100.996604ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:09:25.109336Z","caller":"traceutil/trace.go:171","msg":"trace[2017499789] transaction","detail":"{read_only:false; response_revision:8929; number_of_response:1; }","duration":"113.988408ms","start":"2026-10-19T02:09:24.995314Z","end":"2026-10-19T02:09:25.109303Z","steps":["trace[2017499789] 'process raft request' (duration: 113.039014ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:09:38.945537Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024ae.wal"} {"level":"info","ts":"2026-10-19T02:10:37.704502Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:10:37.720438Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-19T02:10:37.720528Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-19T02:12:31.326235Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8012} {"level":"info","ts":"2026-10-19T02:12:31.39735Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8012,"took":"69.114598ms","hash":1741122998,"current-db-size-bytes":56287232,"current-db-size":"56 MB","current-db-size-in-use-bytes":28708864,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-19T02:12:31.397465Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1741122998,"revision":8012,"compact-revision":5824} {"level":"info","ts":"2026-10-19T02:14:25.148955Z","caller":"traceutil/trace.go:171","msg":"trace[1682569968] transaction","detail":"{read_only:false; response_revision:11521; number_of_response:1; }","duration":"112.235475ms","start":"2026-10-19T02:14:25.036676Z","end":"2026-10-19T02:14:25.148912Z","steps":["trace[1682569968] 'process raft request' (duration: 111.806384ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:17:31.333869Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10463} {"level":"info","ts":"2026-10-19T02:17:31.425244Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10463,"took":"89.104381ms","hash":2146245770,"current-db-size-bytes":56287232,"current-db-size":"56 MB","current-db-size-in-use-bytes":27623424,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-19T02:17:31.425378Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2146245770,"revision":10463,"compact-revision":8012} {"level":"warn","ts":"2026-10-19T02:20:36.192504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.764811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-10-19T02:20:36.192561Z","caller":"traceutil/trace.go:171","msg":"trace[846680891] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:14021; }","duration":"300.863353ms","start":"2026-10-19T02:20:35.891685Z","end":"2026-10-19T02:20:36.192548Z","steps":["trace[846680891] 'range keys from in-memory index tree' (duration: 300.590436ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:36.192582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:20:35.891664Z","time spent":"300.913245ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-10-19T02:20:36.399507Z","caller":"traceutil/trace.go:171","msg":"trace[1374825951] transaction","detail":"{read_only:false; response_revision:14023; number_of_response:1; }","duration":"120.719742ms","start":"2026-10-19T02:20:36.278757Z","end":"2026-10-19T02:20:36.399477Z","steps":["trace[1374825951] 'process raft request' (duration: 106.278229ms)","trace[1374825951] 'compare' (duration: 13.791278ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:20:49.50708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.968724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:20:49.507174Z","caller":"traceutil/trace.go:171","msg":"trace[23973995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14107; }","duration":"168.105698ms","start":"2026-10-19T02:20:49.339051Z","end":"2026-10-19T02:20:49.507157Z","steps":["trace[23973995] 'range keys from in-memory index tree' (duration: 167.875052ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:49.507202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.691047ms","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-10-19T02:20:49.507277Z","caller":"traceutil/trace.go:171","msg":"trace[901505175] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14107; }","duration":"194.83147ms","start":"2026-10-19T02:20:49.312429Z","end":"2026-10-19T02:20:49.507261Z","steps":["trace[901505175] 'range keys from in-memory index tree' (duration: 194.509182ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:49.507305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.892125ms","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-10-19T02:20:49.50738Z","caller":"traceutil/trace.go:171","msg":"trace[573036863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14107; }","duration":"184.008458ms","start":"2026-10-19T02:20:49.323355Z","end":"2026-10-19T02:20:49.507364Z","steps":["trace[573036863] 'range keys from in-memory index tree' (duration: 183.748212ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:49.507482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.876849ms","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-10-19T02:20:49.507525Z","caller":"traceutil/trace.go:171","msg":"trace[1561799827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14107; }","duration":"176.958821ms","start":"2026-10-19T02:20:49.330555Z","end":"2026-10-19T02:20:49.507514Z","steps":["trace[1561799827] 'range keys from in-memory index tree' (duration: 176.725825ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:20:53.696368Z","caller":"traceutil/trace.go:171","msg":"trace[2076393808] linearizableReadLoop","detail":"{readStateIndex:14623; appliedIndex:14622; }","duration":"112.578198ms","start":"2026-10-19T02:20:53.583768Z","end":"2026-10-19T02:20:53.696346Z","steps":["trace[2076393808] 'read index received' (duration: 112.411094ms)","trace[2076393808] 'applied index is now lower than readState.Index' (duration: 166.024µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:20:53.696432Z","caller":"traceutil/trace.go:171","msg":"trace[901350048] transaction","detail":"{read_only:false; response_revision:14133; number_of_response:1; }","duration":"158.344712ms","start":"2026-10-19T02:20:53.538052Z","end":"2026-10-19T02:20:53.696397Z","steps":["trace[901350048] 'process raft request' (duration: 158.133366ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:53.696589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.810234ms","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-10-19T02:20:53.696628Z","caller":"traceutil/trace.go:171","msg":"trace[345626591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14133; }","duration":"112.894166ms","start":"2026-10-19T02:20:53.583724Z","end":"2026-10-19T02:20:53.696618Z","steps":["trace[345626591] 'agreement among raft nodes before linearized reading' (duration: 112.761673ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:53.696684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.125016ms","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-10-19T02:20:53.696742Z","caller":"traceutil/trace.go:171","msg":"trace[833311997] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14133; }","duration":"110.211929ms","start":"2026-10-19T02:20:53.586514Z","end":"2026-10-19T02:20:53.696726Z","steps":["trace[833311997] 'agreement among raft nodes before linearized reading' (duration: 109.983953ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:54.223399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.074189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:20:54.223786Z","caller":"traceutil/trace.go:171","msg":"trace[284882536] transaction","detail":"{read_only:false; response_revision:14134; number_of_response:1; }","duration":"522.802249ms","start":"2026-10-19T02:20:53.700961Z","end":"2026-10-19T02:20:54.223764Z","steps":["trace[284882536] 'process raft request' (duration: 100.255248ms)","trace[284882536] 'compare' (duration: 421.617488ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:20:54.223891Z","caller":"traceutil/trace.go:171","msg":"trace[529534943] transaction","detail":"{read_only:false; response_revision:14135; number_of_response:1; }","duration":"521.777713ms","start":"2026-10-19T02:20:53.702072Z","end":"2026-10-19T02:20:54.223849Z","steps":["trace[529534943] 'process raft request' (duration: 521.616768ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:54.223903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:20:53.700943Z","time spent":"522.891691ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:20:54.223966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:20:53.702043Z","time spent":"521.882426ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:20:54.245576Z","caller":"traceutil/trace.go:171","msg":"trace[42077778] linearizableReadLoop","detail":"{readStateIndex:14626; appliedIndex:14625; }","duration":"223.831742ms","start":"2026-10-19T02:20:54.021726Z","end":"2026-10-19T02:20:54.245558Z","steps":["trace[42077778] 'read index received' (duration: 223.688199ms)","trace[42077778] 'applied index is now lower than readState.Index' (duration: 142.693µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:20:54.24568Z","caller":"traceutil/trace.go:171","msg":"trace[848731606] transaction","detail":"{read_only:false; response_revision:14136; number_of_response:1; }","duration":"327.742171ms","start":"2026-10-19T02:20:53.917912Z","end":"2026-10-19T02:20:54.245655Z","steps":["trace[848731606] 'process raft request' (duration: 327.541716ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:54.245725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.998506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-19T02:20:54.245755Z","caller":"traceutil/trace.go:171","msg":"trace[1795811413] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:14136; }","duration":"224.039547ms","start":"2026-10-19T02:20:54.021707Z","end":"2026-10-19T02:20:54.245746Z","steps":["trace[1795811413] 'agreement among raft nodes before linearized reading' (duration: 223.912084ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:54.245768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:20:53.917886Z","time spent":"327.836034ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:21:51.433248Z","caller":"traceutil/trace.go:171","msg":"trace[1836855930] linearizableReadLoop","detail":"{readStateIndex:15435; appliedIndex:15434; }","duration":"132.613245ms","start":"2026-10-19T02:21:51.300602Z","end":"2026-10-19T02:21:51.433216Z","steps":["trace[1836855930] 'read index received' (duration: 132.526153ms)","trace[1836855930] 'applied index is now lower than readState.Index' (duration: 86.212µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:21:51.433326Z","caller":"traceutil/trace.go:171","msg":"trace[292648964] transaction","detail":"{read_only:false; response_revision:14921; number_of_response:1; }","duration":"136.705398ms","start":"2026-10-19T02:21:51.296586Z","end":"2026-10-19T02:21:51.433291Z","steps":["trace[292648964] 'process raft request' (duration: 136.463112ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:21:51.433616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.993504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:112360"} {"level":"info","ts":"2026-10-19T02:21:51.433673Z","caller":"traceutil/trace.go:171","msg":"trace[826069063] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:14921; }","duration":"133.071167ms","start":"2026-10-19T02:21:51.300576Z","end":"2026-10-19T02:21:51.433647Z","steps":["trace[826069063] 'agreement among raft nodes before linearized reading' (duration: 132.774589ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:21:51.449396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.704132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-19T02:21:51.449387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.659114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:21:51.449478Z","caller":"traceutil/trace.go:171","msg":"trace[809700231] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:14922; }","duration":"147.812955ms","start":"2026-10-19T02:21:51.301647Z","end":"2026-10-19T02:21:51.44946Z","steps":["trace[809700231] 'agreement among raft nodes before linearized reading' (duration: 147.666572ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:21:51.449503Z","caller":"traceutil/trace.go:171","msg":"trace[562496309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14922; }","duration":"109.821508ms","start":"2026-10-19T02:21:51.339655Z","end":"2026-10-19T02:21:51.449477Z","steps":["trace[562496309] 'agreement among raft nodes before linearized reading' (duration: 109.611002ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:22:31.346035Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12746} {"level":"info","ts":"2026-10-19T02:22:31.432471Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12746,"took":"83.558552ms","hash":665839176,"current-db-size-bytes":56287232,"current-db-size":"56 MB","current-db-size-in-use-bytes":30318592,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-19T02:22:31.432541Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":665839176,"revision":12746,"compact-revision":10463} {"level":"info","ts":"2026-10-19T02:22:43.886149Z","caller":"traceutil/trace.go:171","msg":"trace[1259890126] transaction","detail":"{read_only:false; response_revision:15257; number_of_response:1; }","duration":"144.354907ms","start":"2026-10-19T02:22:43.741773Z","end":"2026-10-19T02:22:43.886128Z","steps":["trace[1259890126] 'process raft request' (duration: 144.146792ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:22:44.826216Z","caller":"traceutil/trace.go:171","msg":"trace[1920122946] transaction","detail":"{read_only:false; response_revision:15262; number_of_response:1; }","duration":"107.110819ms","start":"2026-10-19T02:22:44.719066Z","end":"2026-10-19T02:22:44.826177Z","steps":["trace[1920122946] 'process raft request' (duration: 106.865734ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:22:44.996351Z","caller":"traceutil/trace.go:171","msg":"trace[2010372446] transaction","detail":"{read_only:false; response_revision:15263; number_of_response:1; }","duration":"147.496087ms","start":"2026-10-19T02:22:44.848817Z","end":"2026-10-19T02:22:44.996313Z","steps":["trace[2010372446] 'process raft request' (duration: 141.367574ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:23:00.359583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.826882ms","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-10-19T02:23:00.359618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.258557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5ctrj\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-19T02:23:00.359704Z","caller":"traceutil/trace.go:171","msg":"trace[1231787550] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15341; }","duration":"185.976076ms","start":"2026-10-19T02:23:00.173703Z","end":"2026-10-19T02:23:00.359679Z","steps":["trace[1231787550] 'range keys from in-memory index tree' (duration: 185.77071ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:23:00.359656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.902632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-19T02:23:00.359718Z","caller":"traceutil/trace.go:171","msg":"trace[380946922] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5ctrj; range_end:; response_count:1; response_revision:15341; }","duration":"126.394681ms","start":"2026-10-19T02:23:00.233298Z","end":"2026-10-19T02:23:00.359693Z","steps":["trace[380946922] 'range keys from in-memory index tree' (duration: 126.073123ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:23:00.359821Z","caller":"traceutil/trace.go:171","msg":"trace[85901036] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15341; }","duration":"155.069866ms","start":"2026-10-19T02:23:00.204687Z","end":"2026-10-19T02:23:00.359757Z","steps":["trace[85901036] 'range keys from in-memory index tree' (duration: 154.755438ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:23:00.35997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.382786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-19T02:23:00.360039Z","caller":"traceutil/trace.go:171","msg":"trace[784756436] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15341; }","duration":"186.477858ms","start":"2026-10-19T02:23:00.173527Z","end":"2026-10-19T02:23:00.360005Z","steps":["trace[784756436] 'range keys from in-memory index tree' (duration: 186.197871ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:01.501891Z","caller":"traceutil/trace.go:171","msg":"trace[263976078] transaction","detail":"{read_only:false; response_revision:16292; number_of_response:1; }","duration":"119.551005ms","start":"2026-10-19T02:25:01.382308Z","end":"2026-10-19T02:25:01.501859Z","steps":["trace[263976078] 'process raft request' (duration: 119.33899ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:32.57362Z","caller":"traceutil/trace.go:171","msg":"trace[1923329768] linearizableReadLoop","detail":"{readStateIndex:17221; appliedIndex:17219; }","duration":"101.099694ms","start":"2026-10-19T02:25:32.472486Z","end":"2026-10-19T02:25:32.573586Z","steps":["trace[1923329768] 'read index received' (duration: 23.53091ms)","trace[1923329768] 'applied index is now lower than readState.Index' (duration: 77.566764ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:25:32.573741Z","caller":"traceutil/trace.go:171","msg":"trace[460251464] transaction","detail":"{read_only:false; response_revision:16650; number_of_response:1; }","duration":"125.592117ms","start":"2026-10-19T02:25:32.448114Z","end":"2026-10-19T02:25:32.573706Z","steps":["trace[460251464] 'process raft request' (duration: 124.793706ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:25:32.573865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.341329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-10-19T02:25:32.573919Z","caller":"traceutil/trace.go:171","msg":"trace[1533918686] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:16650; }","duration":"101.464773ms","start":"2026-10-19T02:25:32.472435Z","end":"2026-10-19T02:25:32.5739Z","steps":["trace[1533918686] 'agreement among raft nodes before linearized reading' (duration: 101.294218ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:35.613455Z","caller":"traceutil/trace.go:171","msg":"trace[412551625] transaction","detail":"{read_only:false; response_revision:16671; number_of_response:1; }","duration":"110.667442ms","start":"2026-10-19T02:25:35.502763Z","end":"2026-10-19T02:25:35.613431Z","steps":["trace[412551625] 'process raft request' (duration: 110.228801ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:27:31.353297Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15193} {"level":"info","ts":"2026-10-19T02:27:31.459152Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15193,"took":"103.106208ms","hash":3497744472,"current-db-size-bytes":56287232,"current-db-size":"56 MB","current-db-size-in-use-bytes":31899648,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T02:27:31.459212Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3497744472,"revision":15193,"compact-revision":12746} {"level":"info","ts":"2026-10-19T02:28:18.975773Z","caller":"traceutil/trace.go:171","msg":"trace[1977784048] transaction","detail":"{read_only:false; response_revision:17766; number_of_response:1; }","duration":"151.676251ms","start":"2026-10-19T02:28:18.824073Z","end":"2026-10-19T02:28:18.975749Z","steps":["trace[1977784048] 'process raft request' (duration: 151.165708ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:24.519121Z","caller":"traceutil/trace.go:171","msg":"trace[1435692190] transaction","detail":"{read_only:false; response_revision:17798; number_of_response:1; }","duration":"210.46629ms","start":"2026-10-19T02:28:24.308634Z","end":"2026-10-19T02:28:24.5191Z","steps":["trace[1435692190] 'process raft request' (duration: 210.324837ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:25.004462Z","caller":"traceutil/trace.go:171","msg":"trace[867213306] linearizableReadLoop","detail":"{readStateIndex:18410; appliedIndex:18408; }","duration":"685.608584ms","start":"2026-10-19T02:28:24.318811Z","end":"2026-10-19T02:28:25.004419Z","steps":["trace[867213306] 'read index received' (duration: 200.180453ms)","trace[867213306] 'applied index is now lower than readState.Index' (duration: 485.426861ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:28:25.004569Z","caller":"traceutil/trace.go:171","msg":"trace[1017734546] transaction","detail":"{read_only:false; response_revision:17799; number_of_response:1; }","duration":"691.969742ms","start":"2026-10-19T02:28:24.31255Z","end":"2026-10-19T02:28:25.004519Z","steps":["trace[1017734546] 'process raft request' (duration: 672.891916ms)","trace[1017734546] 'compare' (duration: 18.162373ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:28:25.004666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.432474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:28:25.004711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:28:24.31253Z","time spent":"692.100696ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:28:25.004734Z","caller":"traceutil/trace.go:171","msg":"trace[829003422] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:17799; }","duration":"632.508666ms","start":"2026-10-19T02:28:24.372205Z","end":"2026-10-19T02:28:25.004714Z","steps":["trace[829003422] 'agreement among raft nodes before linearized reading' (duration: 632.407914ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:28:25.004767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:28:24.372138Z","time spent":"632.619699ms","remote":"127.0.0.1:48224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:28:25.004778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.954362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-xvpqp\" ","response":"range_response_count:1 size:20910"} {"level":"info","ts":"2026-10-19T02:28:25.004858Z","caller":"traceutil/trace.go:171","msg":"trace[898766923] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-xvpqp; range_end:; response_count:1; response_revision:17799; }","duration":"686.048115ms","start":"2026-10-19T02:28:24.318761Z","end":"2026-10-19T02:28:25.004809Z","steps":["trace[898766923] 'agreement among raft nodes before linearized reading' (duration: 685.838979ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:28:25.004897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:28:24.31874Z","time spent":"686.147466ms","remote":"127.0.0.1:47592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20934,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-xvpqp\" "} {"level":"warn","ts":"2026-10-19T02:28:25.005109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.011319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.128\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-10-19T02:28:25.005136Z","caller":"traceutil/trace.go:171","msg":"trace[1505844411] range","detail":"{range_begin:/registry/masterleases/162.253.55.128; range_end:; response_count:1; response_revision:17799; }","duration":"218.074901ms","start":"2026-10-19T02:28:24.787053Z","end":"2026-10-19T02:28:25.005128Z","steps":["trace[1505844411] 'agreement among raft nodes before linearized reading' (duration: 217.990898ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:25.150323Z","caller":"traceutil/trace.go:171","msg":"trace[594869056] transaction","detail":"{read_only:false; response_revision:17800; number_of_response:1; }","duration":"141.492576ms","start":"2026-10-19T02:28:25.008803Z","end":"2026-10-19T02:28:25.150295Z","steps":["trace[594869056] 'process raft request' (duration: 140.85082ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:28:25.150787Z","caller":"traceutil/trace.go:171","msg":"trace[1632554160] transaction","detail":"{read_only:false; response_revision:17801; number_of_response:1; }","duration":"125.366783ms","start":"2026-10-19T02:28:25.0254Z","end":"2026-10-19T02:28:25.150767Z","steps":["trace[1632554160] 'process raft request' (duration: 124.496071ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:31:24.214802Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:31:24.222996Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-19T02:31:24.22317Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-19T02:32:31.360814Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17415} {"level":"info","ts":"2026-10-19T02:32:31.464543Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17415,"took":"100.328229ms","hash":2192199709,"current-db-size-bytes":56287232,"current-db-size":"56 MB","current-db-size-in-use-bytes":34828288,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-19T02:32:31.464618Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2192199709,"revision":17415,"compact-revision":15193} {"level":"info","ts":"2026-10-19T02:33:33.587721Z","caller":"traceutil/trace.go:171","msg":"trace[1601448465] transaction","detail":"{read_only:false; response_revision:20286; number_of_response:1; }","duration":"102.020162ms","start":"2026-10-19T02:33:33.485671Z","end":"2026-10-19T02:33:33.587691Z","steps":["trace[1601448465] 'process raft request' (duration: 101.815067ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:33:39.008888Z","caller":"traceutil/trace.go:171","msg":"trace[280634193] linearizableReadLoop","detail":"{readStateIndex:21006; appliedIndex:21005; }","duration":"123.947351ms","start":"2026-10-19T02:33:38.884913Z","end":"2026-10-19T02:33:39.00886Z","steps":["trace[280634193] 'read index received' (duration: 123.214003ms)","trace[280634193] 'applied index is now lower than readState.Index' (duration: 732.098µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:33:39.008928Z","caller":"traceutil/trace.go:171","msg":"trace[1748124662] transaction","detail":"{read_only:false; response_revision:20315; number_of_response:1; }","duration":"128.217819ms","start":"2026-10-19T02:33:38.880679Z","end":"2026-10-19T02:33:39.008897Z","steps":["trace[1748124662] 'process raft request' (duration: 127.615084ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:33:39.009218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.30484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-19T02:33:39.009389Z","caller":"traceutil/trace.go:171","msg":"trace[536209497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20315; }","duration":"124.554867ms","start":"2026-10-19T02:33:38.884815Z","end":"2026-10-19T02:33:39.00937Z","steps":["trace[536209497] 'agreement among raft nodes before linearized reading' (duration: 124.182257ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:33:39.342517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.072719ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:33:39.342651Z","caller":"traceutil/trace.go:171","msg":"trace[232516481] transaction","detail":"{read_only:false; response_revision:20316; number_of_response:1; }","duration":"329.265677ms","start":"2026-10-19T02:33:39.013355Z","end":"2026-10-19T02:33:39.342621Z","steps":["trace[232516481] 'process raft request' (duration: 162.988102ms)","trace[232516481] 'compare' (duration: 165.946416ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:33:39.342731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:33:39.013331Z","time spent":"329.358539ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:33:39.349438Z","caller":"traceutil/trace.go:171","msg":"trace[1576744634] transaction","detail":"{read_only:false; response_revision:20317; number_of_response:1; }","duration":"335.680748ms","start":"2026-10-19T02:33:39.013716Z","end":"2026-10-19T02:33:39.349397Z","steps":["trace[1576744634] 'process raft request' (duration: 335.507614ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:33:39.349603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:33:39.01369Z","time spent":"335.828961ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:33:49.781355Z","caller":"traceutil/trace.go:171","msg":"trace[1021166340] transaction","detail":"{read_only:false; response_revision:20369; number_of_response:1; }","duration":"106.695759ms","start":"2026-10-19T02:33:49.674637Z","end":"2026-10-19T02:33:49.781333Z","steps":["trace[1021166340] 'process raft request' (duration: 106.110794ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:33:55.581637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.589045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-10-19T02:33:55.581683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.327805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:33:55.581732Z","caller":"traceutil/trace.go:171","msg":"trace[41639305] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20397; }","duration":"133.76611ms","start":"2026-10-19T02:33:55.447942Z","end":"2026-10-19T02:33:55.581708Z","steps":["trace[41639305] 'range keys from in-memory index tree' (duration: 133.278537ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:33:55.581778Z","caller":"traceutil/trace.go:171","msg":"trace[732602722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20397; }","duration":"242.483289ms","start":"2026-10-19T02:33:55.339273Z","end":"2026-10-19T02:33:55.581756Z","steps":["trace[732602722] 'range keys from in-memory index tree' (duration: 242.174421ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:33:55.581962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.633529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-19T02:33:55.581817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.732142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-19T02:33:55.582153Z","caller":"traceutil/trace.go:171","msg":"trace[746950623] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:20397; }","duration":"269.925977ms","start":"2026-10-19T02:33:55.312199Z","end":"2026-10-19T02:33:55.582125Z","steps":["trace[746950623] 'count revisions from in-memory index tree' (duration: 269.463596ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:33:55.582182Z","caller":"traceutil/trace.go:171","msg":"trace[193818330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20397; }","duration":"164.119002ms","start":"2026-10-19T02:33:55.418017Z","end":"2026-10-19T02:33:55.582136Z","steps":["trace[193818330] 'range keys from in-memory index tree' (duration: 163.565437ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:33:55.581881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.184585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-19T02:33:55.582333Z","caller":"traceutil/trace.go:171","msg":"trace[686010091] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20397; }","duration":"135.664756ms","start":"2026-10-19T02:33:55.446642Z","end":"2026-10-19T02:33:55.582306Z","steps":["trace[686010091] 'range keys from in-memory index tree' (duration: 134.966779ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:33:55.726439Z","caller":"traceutil/trace.go:171","msg":"trace[153071207] transaction","detail":"{read_only:false; response_revision:20398; number_of_response:1; }","duration":"138.952368ms","start":"2026-10-19T02:33:55.587454Z","end":"2026-10-19T02:33:55.726406Z","steps":["trace[153071207] 'process raft request' (duration: 138.770174ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:33:55.741323Z","caller":"traceutil/trace.go:171","msg":"trace[287504723] transaction","detail":"{read_only:false; response_revision:20399; number_of_response:1; }","duration":"153.792532ms","start":"2026-10-19T02:33:55.587505Z","end":"2026-10-19T02:33:55.741298Z","steps":["trace[287504723] 'process raft request' (duration: 153.526825ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:33:55.741454Z","caller":"traceutil/trace.go:171","msg":"trace[1897704023] transaction","detail":"{read_only:false; response_revision:20400; number_of_response:1; }","duration":"153.73848ms","start":"2026-10-19T02:33:55.587688Z","end":"2026-10-19T02:33:55.741427Z","steps":["trace[1897704023] 'process raft request' (duration: 153.527024ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:33:55.937479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.274432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-19T02:33:55.937576Z","caller":"traceutil/trace.go:171","msg":"trace[597344067] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20400; }","duration":"128.450166ms","start":"2026-10-19T02:33:55.809103Z","end":"2026-10-19T02:33:55.937553Z","steps":["trace[597344067] 'range keys from in-memory index tree' (duration: 128.022325ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:33:55.941291Z","caller":"traceutil/trace.go:171","msg":"trace[1608963262] transaction","detail":"{read_only:false; response_revision:20401; number_of_response:1; }","duration":"124.632689ms","start":"2026-10-19T02:33:55.81664Z","end":"2026-10-19T02:33:55.941273Z","steps":["trace[1608963262] 'process raft request' (duration: 124.469415ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:33:56.311786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.347694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:33:56.311968Z","caller":"traceutil/trace.go:171","msg":"trace[10669744] linearizableReadLoop","detail":"{readStateIndex:21098; appliedIndex:21096; }","duration":"272.042121ms","start":"2026-10-19T02:33:56.039913Z","end":"2026-10-19T02:33:56.311955Z","steps":["trace[10669744] 'read index received' (duration: 88.560393ms)","trace[10669744] 'applied index is now lower than readState.Index' (duration: 183.480858ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:33:56.312063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.141803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:33:56.312086Z","caller":"traceutil/trace.go:171","msg":"trace[861118045] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:20403; }","duration":"272.229275ms","start":"2026-10-19T02:33:56.039849Z","end":"2026-10-19T02:33:56.312078Z","steps":["trace[861118045] 'agreement among raft nodes before linearized reading' (duration: 272.147473ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:33:56.312147Z","caller":"traceutil/trace.go:171","msg":"trace[942516956] transaction","detail":"{read_only:false; response_revision:20402; number_of_response:1; }","duration":"368.971894ms","start":"2026-10-19T02:33:55.943129Z","end":"2026-10-19T02:33:56.312101Z","steps":["trace[942516956] 'process raft request' (duration: 185.23733ms)","trace[942516956] 'compare' (duration: 183.119668ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:33:56.312258Z","caller":"traceutil/trace.go:171","msg":"trace[1096209486] transaction","detail":"{read_only:false; response_revision:20403; number_of_response:1; }","duration":"366.477141ms","start":"2026-10-19T02:33:55.945774Z","end":"2026-10-19T02:33:56.312251Z","steps":["trace[1096209486] 'process raft request' (duration: 366.122762ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:33:56.312485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:33:55.945742Z","time spent":"366.721308ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:33:56.312519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:33:55.943108Z","time spent":"369.130547ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:33:56.702885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.730471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:33:56.703146Z","caller":"traceutil/trace.go:171","msg":"trace[858946900] transaction","detail":"{read_only:false; response_revision:20405; number_of_response:1; }","duration":"207.690385ms","start":"2026-10-19T02:33:56.495433Z","end":"2026-10-19T02:33:56.703124Z","steps":["trace[858946900] 'process raft request' (duration: 207.562261ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:33:56.703201Z","caller":"traceutil/trace.go:171","msg":"trace[467242975] linearizableReadLoop","detail":"{readStateIndex:21099; appliedIndex:21098; }","duration":"285.965819ms","start":"2026-10-19T02:33:56.417194Z","end":"2026-10-19T02:33:56.70316Z","steps":["trace[467242975] 'read index received' (duration: 64.733245ms)","trace[467242975] 'applied index is now lower than readState.Index' (duration: 221.227974ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:33:56.703428Z","caller":"traceutil/trace.go:171","msg":"trace[1601261363] transaction","detail":"{read_only:false; response_revision:20404; number_of_response:1; }","duration":"331.446652ms","start":"2026-10-19T02:33:56.371951Z","end":"2026-10-19T02:33:56.703398Z","steps":["trace[1601261363] 'process raft request' (duration: 110.073324ms)","trace[1601261363] 'compare' (duration: 220.499065ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:33:56.703536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.273568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-19T02:33:56.703593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:33:56.371932Z","time spent":"331.570835ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:33:56.703691Z","caller":"traceutil/trace.go:171","msg":"trace[1308921791] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:20405; }","duration":"286.502164ms","start":"2026-10-19T02:33:56.417135Z","end":"2026-10-19T02:33:56.703637Z","steps":["trace[1308921791] 'agreement among raft nodes before linearized reading' (duration: 286.092293ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:31.369402Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19932} {"level":"info","ts":"2026-10-19T02:37:31.524222Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19932,"took":"151.894088ms","hash":1482639716,"current-db-size-bytes":56287232,"current-db-size":"56 MB","current-db-size-in-use-bytes":30588928,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:37:31.524294Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1482639716,"revision":19932,"compact-revision":17415} {"level":"info","ts":"2026-10-19T02:37:49.887305Z","caller":"traceutil/trace.go:171","msg":"trace[277955379] transaction","detail":"{read_only:false; response_revision:22844; number_of_response:1; }","duration":"105.875154ms","start":"2026-10-19T02:37:49.781402Z","end":"2026-10-19T02:37:49.887278Z","steps":["trace[277955379] 'process raft request' (duration: 101.660408ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:39:18.361255Z","caller":"traceutil/trace.go:171","msg":"trace[320732723] linearizableReadLoop","detail":"{readStateIndex:24575; appliedIndex:24574; }","duration":"119.191862ms","start":"2026-10-19T02:39:18.242036Z","end":"2026-10-19T02:39:18.361228Z","steps":["trace[320732723] 'read index received' (duration: 97.505258ms)","trace[320732723] 'applied index is now lower than readState.Index' (duration: 21.685334ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:39:18.361341Z","caller":"traceutil/trace.go:171","msg":"trace[1929753705] transaction","detail":"{read_only:false; response_revision:23786; number_of_response:1; }","duration":"140.022124ms","start":"2026-10-19T02:39:18.221283Z","end":"2026-10-19T02:39:18.361306Z","steps":["trace[1929753705] 'process raft request' (duration: 118.461113ms)","trace[1929753705] 'compare' (duration: 21.361266ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:39:18.361399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.337515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:39:18.361434Z","caller":"traceutil/trace.go:171","msg":"trace[1106850631] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:23786; }","duration":"119.443718ms","start":"2026-10-19T02:39:18.241979Z","end":"2026-10-19T02:39:18.361422Z","steps":["trace[1106850631] 'agreement among raft nodes before linearized reading' (duration: 119.353376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:41:10.47595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.289322ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:41:10.476059Z","caller":"traceutil/trace.go:171","msg":"trace[189789600] linearizableReadLoop","detail":"{readStateIndex:25662; appliedIndex:25661; }","duration":"242.749348ms","start":"2026-10-19T02:41:10.233293Z","end":"2026-10-19T02:41:10.476042Z","steps":["trace[189789600] 'read index received' (duration: 116.253392ms)","trace[189789600] 'applied index is now lower than readState.Index' (duration: 126.494526ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:41:10.476169Z","caller":"traceutil/trace.go:171","msg":"trace[612658293] transaction","detail":"{read_only:false; response_revision:24847; number_of_response:1; }","duration":"298.549296ms","start":"2026-10-19T02:41:10.177581Z","end":"2026-10-19T02:41:10.476131Z","steps":["trace[612658293] 'process raft request' (duration: 171.945696ms)","trace[612658293] 'compare' (duration: 126.090778ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:41:10.47636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.061006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-10-19T02:41:10.476405Z","caller":"traceutil/trace.go:171","msg":"trace[1623263455] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24847; }","duration":"243.163138ms","start":"2026-10-19T02:41:10.233226Z","end":"2026-10-19T02:41:10.476389Z","steps":["trace[1623263455] 'agreement among raft nodes before linearized reading' (duration: 242.86092ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:41:10.569912Z","caller":"traceutil/trace.go:171","msg":"trace[900968828] transaction","detail":"{read_only:false; response_revision:24848; number_of_response:1; }","duration":"167.622268ms","start":"2026-10-19T02:41:10.402247Z","end":"2026-10-19T02:41:10.56987Z","steps":["trace[900968828] 'process raft request' (duration: 167.469344ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:41:10.570001Z","caller":"traceutil/trace.go:171","msg":"trace[704424157] transaction","detail":"{read_only:false; response_revision:24849; number_of_response:1; }","duration":"113.115253ms","start":"2026-10-19T02:41:10.456836Z","end":"2026-10-19T02:41:10.569951Z","steps":["trace[704424157] 'process raft request' (duration: 112.971139ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:41:10.98266Z","caller":"traceutil/trace.go:171","msg":"trace[2026120132] transaction","detail":"{read_only:false; response_revision:24851; number_of_response:1; }","duration":"152.895069ms","start":"2026-10-19T02:41:10.829738Z","end":"2026-10-19T02:41:10.982633Z","steps":["trace[2026120132] 'process raft request' (duration: 152.733585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:41:11.45323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.293531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:41:11.453536Z","caller":"traceutil/trace.go:171","msg":"trace[502207064] transaction","detail":"{read_only:false; response_revision:24852; number_of_response:1; }","duration":"594.28487ms","start":"2026-10-19T02:41:10.859223Z","end":"2026-10-19T02:41:11.453508Z","steps":["trace[502207064] 'process raft request' (duration: 378.61309ms)","trace[502207064] 'compare' (duration: 214.934113ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:41:11.453559Z","caller":"traceutil/trace.go:171","msg":"trace[1737577772] linearizableReadLoop","detail":"{readStateIndex:25668; appliedIndex:25666; }","duration":"514.699918ms","start":"2026-10-19T02:41:10.938841Z","end":"2026-10-19T02:41:11.453541Z","steps":["trace[1737577772] 'read index received' (duration: 43.642204ms)","trace[1737577772] 'applied index is now lower than readState.Index' (duration: 471.053044ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:41:11.453695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:41:10.859197Z","time spent":"594.407204ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:41:11.453761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.037945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:41:11.453795Z","caller":"traceutil/trace.go:171","msg":"trace[822352327] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24852; }","duration":"261.097737ms","start":"2026-10-19T02:41:11.192689Z","end":"2026-10-19T02:41:11.453786Z","steps":["trace[822352327] 'agreement among raft nodes before linearized reading' (duration: 261.025666ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:41:11.453782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.926874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-10-19T02:41:11.453833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.813619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:41:11.45386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.13289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:41:11.453886Z","caller":"traceutil/trace.go:171","msg":"trace[2120308306] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24852; }","duration":"113.903782ms","start":"2026-10-19T02:41:11.339968Z","end":"2026-10-19T02:41:11.453872Z","steps":["trace[2120308306] 'agreement among raft nodes before linearized reading' (duration: 113.819489ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:41:11.453884Z","caller":"traceutil/trace.go:171","msg":"trace[2066391258] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24852; }","duration":"515.055487ms","start":"2026-10-19T02:41:10.938792Z","end":"2026-10-19T02:41:11.453847Z","steps":["trace[2066391258] 'agreement among raft nodes before linearized reading' (duration: 514.826921ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:41:11.453952Z","caller":"traceutil/trace.go:171","msg":"trace[279578523] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:24852; }","duration":"424.245473ms","start":"2026-10-19T02:41:11.029665Z","end":"2026-10-19T02:41:11.453911Z","steps":["trace[279578523] 'agreement among raft nodes before linearized reading' (duration: 424.050078ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:41:11.453965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:41:10.938775Z","time spent":"515.18011ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-19T02:41:11.453994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:41:11.029648Z","time spent":"424.336074ms","remote":"127.0.0.1:47808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":32,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:41:11.454066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.726883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:41:11.454092Z","caller":"traceutil/trace.go:171","msg":"trace[1694685946] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:24852; }","duration":"396.773105ms","start":"2026-10-19T02:41:11.057309Z","end":"2026-10-19T02:41:11.454082Z","steps":["trace[1694685946] 'agreement among raft nodes before linearized reading' (duration: 396.729424ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:41:11.454116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:41:11.057298Z","time spent":"396.811656ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":30,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:41:11.454168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.335008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-10-19T02:41:11.454242Z","caller":"traceutil/trace.go:171","msg":"trace[1463535700] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24852; }","duration":"353.43192ms","start":"2026-10-19T02:41:11.100797Z","end":"2026-10-19T02:41:11.454229Z","steps":["trace[1463535700] 'agreement among raft nodes before linearized reading' (duration: 353.182073ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:41:11.454276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:41:11.100787Z","time spent":"353.479342ms","remote":"127.0.0.1:47896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11861,"request content":"key:\"/registry/deployments/openstack/glance-api\" "} {"level":"warn","ts":"2026-10-19T02:42:15.928557Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11757668625140345650,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-19T02:42:15.965808Z","caller":"traceutil/trace.go:171","msg":"trace[2001497933] transaction","detail":"{read_only:false; response_revision:25430; number_of_response:1; }","duration":"609.988225ms","start":"2026-10-19T02:42:15.355794Z","end":"2026-10-19T02:42:15.965783Z","steps":["trace[2001497933] 'process raft request' (duration: 609.860802ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:15.965925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:42:15.355775Z","time spent":"610.082777ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:42:15.999111Z","caller":"traceutil/trace.go:171","msg":"trace[1081520881] transaction","detail":"{read_only:false; response_revision:25431; number_of_response:1; }","duration":"305.326005ms","start":"2026-10-19T02:42:15.693768Z","end":"2026-10-19T02:42:15.999094Z","steps":["trace[1081520881] 'process raft request' (duration: 305.199692ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:15.999204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:42:15.693727Z","time spent":"305.426458ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:42:15.999463Z","caller":"traceutil/trace.go:171","msg":"trace[101819365] transaction","detail":"{read_only:false; response_revision:25432; number_of_response:1; }","duration":"115.440501ms","start":"2026-10-19T02:42:15.88401Z","end":"2026-10-19T02:42:15.999451Z","steps":["trace[101819365] 'process raft request' (duration: 115.047681ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:15.999528Z","caller":"traceutil/trace.go:171","msg":"trace[1208075207] transaction","detail":"{read_only:false; response_revision:25433; number_of_response:1; }","duration":"115.4534ms","start":"2026-10-19T02:42:15.884051Z","end":"2026-10-19T02:42:15.999505Z","steps":["trace[1208075207] 'process raft request' (duration: 115.263386ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:15.999565Z","caller":"traceutil/trace.go:171","msg":"trace[1877122654] transaction","detail":"{read_only:false; response_revision:25434; number_of_response:1; }","duration":"105.352498ms","start":"2026-10-19T02:42:15.894176Z","end":"2026-10-19T02:42:15.999529Z","steps":["trace[1877122654] 'process raft request' (duration: 105.266116ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:15.999529Z","caller":"traceutil/trace.go:171","msg":"trace[1304322168] linearizableReadLoop","detail":"{readStateIndex:26264; appliedIndex:26259; }","duration":"571.680865ms","start":"2026-10-19T02:42:15.427819Z","end":"2026-10-19T02:42:15.9995Z","steps":["trace[1304322168] 'read index received' (duration: 537.828738ms)","trace[1304322168] 'applied index is now lower than readState.Index' (duration: 33.850937ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:42:15.999719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.805547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:42:15.999724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.892559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-10-19T02:42:15.999761Z","caller":"traceutil/trace.go:171","msg":"trace[580621508] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:25434; }","duration":"533.882858ms","start":"2026-10-19T02:42:15.465865Z","end":"2026-10-19T02:42:15.999748Z","steps":["trace[580621508] 'agreement among raft nodes before linearized reading' (duration: 533.813896ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:15.999791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:42:15.465845Z","time spent":"533.93768ms","remote":"127.0.0.1:44204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true "} {"level":"info","ts":"2026-10-19T02:42:15.999785Z","caller":"traceutil/trace.go:171","msg":"trace[700005636] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:25434; }","duration":"571.995472ms","start":"2026-10-19T02:42:15.427767Z","end":"2026-10-19T02:42:15.999763Z","steps":["trace[700005636] 'agreement among raft nodes before linearized reading' (duration: 571.808788ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:15.999801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.256487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:42:15.999837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:42:15.427742Z","time spent":"572.082504ms","remote":"127.0.0.1:47574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1882,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" "} {"level":"info","ts":"2026-10-19T02:42:15.999858Z","caller":"traceutil/trace.go:171","msg":"trace[597023064] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:25434; }","duration":"185.36188ms","start":"2026-10-19T02:42:15.814481Z","end":"2026-10-19T02:42:15.999842Z","steps":["trace[597023064] 'agreement among raft nodes before linearized reading' (duration: 185.268508ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:16.000046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.418082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-19T02:42:16.000165Z","caller":"traceutil/trace.go:171","msg":"trace[1097156732] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25434; }","duration":"183.555655ms","start":"2026-10-19T02:42:15.816578Z","end":"2026-10-19T02:42:16.000134Z","steps":["trace[1097156732] 'agreement among raft nodes before linearized reading' (duration: 183.162655ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:16.374278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.874818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:42:16.374456Z","caller":"traceutil/trace.go:171","msg":"trace[818809087] linearizableReadLoop","detail":"{readStateIndex:26266; appliedIndex:26264; }","duration":"311.408608ms","start":"2026-10-19T02:42:16.063031Z","end":"2026-10-19T02:42:16.37444Z","steps":["trace[818809087] 'read index received' (duration: 158.244392ms)","trace[818809087] 'applied index is now lower than readState.Index' (duration: 153.162786ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:42:16.374525Z","caller":"traceutil/trace.go:171","msg":"trace[902817685] transaction","detail":"{read_only:false; response_revision:25435; number_of_response:1; }","duration":"369.862801ms","start":"2026-10-19T02:42:16.004652Z","end":"2026-10-19T02:42:16.374515Z","steps":["trace[902817685] 'process raft request' (duration: 216.661154ms)","trace[902817685] 'compare' (duration: 152.757785ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:42:16.374576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:42:16.004636Z","time spent":"369.910133ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:42:16.374702Z","caller":"traceutil/trace.go:171","msg":"trace[1551780044] transaction","detail":"{read_only:false; response_revision:25436; number_of_response:1; }","duration":"370.017995ms","start":"2026-10-19T02:42:16.004666Z","end":"2026-10-19T02:42:16.374684Z","steps":["trace[1551780044] 'process raft request' (duration: 369.710757ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:16.374792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:42:16.004653Z","time spent":"370.092046ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:42:16.374806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.770266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:42:16.374838Z","caller":"traceutil/trace.go:171","msg":"trace[1711803862] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:25436; }","duration":"311.847048ms","start":"2026-10-19T02:42:16.062981Z","end":"2026-10-19T02:42:16.374828Z","steps":["trace[1711803862] 'agreement among raft nodes before linearized reading' (duration: 311.762776ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:16.374873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:42:16.062957Z","time spent":"311.90734ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":32,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:42:16.393702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.612299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:42:16.393748Z","caller":"traceutil/trace.go:171","msg":"trace[808424622] transaction","detail":"{read_only:false; response_revision:25437; number_of_response:1; }","duration":"146.322225ms","start":"2026-10-19T02:42:16.247389Z","end":"2026-10-19T02:42:16.393712Z","steps":["trace[808424622] 'process raft request' (duration: 146.070178ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:16.393793Z","caller":"traceutil/trace.go:171","msg":"trace[783206897] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:25437; }","duration":"330.741652ms","start":"2026-10-19T02:42:16.06303Z","end":"2026-10-19T02:42:16.393771Z","steps":["trace[783206897] 'agreement among raft nodes before linearized reading' (duration: 330.585048ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:16.393839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:42:16.063019Z","time spent":"330.811044ms","remote":"127.0.0.1:39128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:42:16.393901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.378468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-10-19T02:42:16.393996Z","caller":"traceutil/trace.go:171","msg":"trace[1707056960] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25437; }","duration":"190.531541ms","start":"2026-10-19T02:42:16.203448Z","end":"2026-10-19T02:42:16.393979Z","steps":["trace[1707056960] 'agreement among raft nodes before linearized reading' (duration: 190.262315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:16.394398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.68703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:42:16.394583Z","caller":"traceutil/trace.go:171","msg":"trace[2079223546] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/networks/; range_end:/registry/openstack.k-orc.cloud/networks0; response_count:0; response_revision:25437; }","duration":"189.893085ms","start":"2026-10-19T02:42:16.204673Z","end":"2026-10-19T02:42:16.394567Z","steps":["trace[2079223546] 'agreement among raft nodes before linearized reading' (duration: 188.974203ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:16.592132Z","caller":"traceutil/trace.go:171","msg":"trace[1680893280] transaction","detail":"{read_only:false; response_revision:25438; number_of_response:1; }","duration":"204.180293ms","start":"2026-10-19T02:42:16.387917Z","end":"2026-10-19T02:42:16.592098Z","steps":["trace[1680893280] 'process raft request' (duration: 201.411973ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:16.592146Z","caller":"traceutil/trace.go:171","msg":"trace[1565119872] linearizableReadLoop","detail":"{readStateIndex:26268; appliedIndex:26267; }","duration":"196.294585ms","start":"2026-10-19T02:42:16.395819Z","end":"2026-10-19T02:42:16.592114Z","steps":["trace[1565119872] 'read index received' (duration: 193.592298ms)","trace[1565119872] 'applied index is now lower than readState.Index' (duration: 2.701237ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:42:16.592481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.315591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"warn","ts":"2026-10-19T02:42:16.592509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.665034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-19T02:42:16.592549Z","caller":"traceutil/trace.go:171","msg":"trace[1179400220] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25439; }","duration":"196.748417ms","start":"2026-10-19T02:42:16.39579Z","end":"2026-10-19T02:42:16.592538Z","steps":["trace[1179400220] 'agreement among raft nodes before linearized reading' (duration: 196.47553ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:16.592546Z","caller":"traceutil/trace.go:171","msg":"trace[395664296] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25439; }","duration":"191.413223ms","start":"2026-10-19T02:42:16.401117Z","end":"2026-10-19T02:42:16.59253Z","steps":["trace[395664296] 'agreement among raft nodes before linearized reading' (duration: 191.209508ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:31.377712Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22128} {"level":"info","ts":"2026-10-19T02:42:31.496366Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22128,"took":"114.60393ms","hash":402910188,"current-db-size-bytes":56287232,"current-db-size":"56 MB","current-db-size-in-use-bytes":44363776,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-10-19T02:42:31.496476Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":402910188,"revision":22128,"compact-revision":19932} {"level":"info","ts":"2026-10-19T02:42:48.557727Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006813.wal"} {"level":"info","ts":"2026-10-19T02:46:07.474141Z","caller":"traceutil/trace.go:171","msg":"trace[1189731162] transaction","detail":"{read_only:false; response_revision:27772; number_of_response:1; }","duration":"144.890536ms","start":"2026-10-19T02:46:07.329222Z","end":"2026-10-19T02:46:07.474112Z","steps":["trace[1189731162] 'process raft request' (duration: 144.747732ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:46:07.579516Z","caller":"traceutil/trace.go:171","msg":"trace[2073286166] linearizableReadLoop","detail":"{readStateIndex:28663; appliedIndex:28661; }","duration":"228.871503ms","start":"2026-10-19T02:46:07.350625Z","end":"2026-10-19T02:46:07.579497Z","steps":["trace[2073286166] 'read index received' (duration: 123.380516ms)","trace[2073286166] 'applied index is now lower than readState.Index' (duration: 105.490037ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:46:07.579558Z","caller":"traceutil/trace.go:171","msg":"trace[63983248] transaction","detail":"{read_only:false; response_revision:27773; number_of_response:1; }","duration":"248.984158ms","start":"2026-10-19T02:46:07.330543Z","end":"2026-10-19T02:46:07.579527Z","steps":["trace[63983248] 'process raft request' (duration: 179.798222ms)","trace[63983248] 'compare' (duration: 69.065173ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:46:07.579677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.045698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-10-19T02:46:07.579713Z","caller":"traceutil/trace.go:171","msg":"trace[1600562637] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:27773; }","duration":"229.142421ms","start":"2026-10-19T02:46:07.350561Z","end":"2026-10-19T02:46:07.579703Z","steps":["trace[1600562637] 'agreement among raft nodes before linearized reading' (duration: 229.009927ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:46:08.405604Z","caller":"traceutil/trace.go:171","msg":"trace[48263402] transaction","detail":"{read_only:false; response_revision:27783; number_of_response:1; }","duration":"104.952864ms","start":"2026-10-19T02:46:08.300636Z","end":"2026-10-19T02:46:08.405589Z","steps":["trace[48263402] 'process raft request' (duration: 104.724098ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:47:31.384822Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25546} {"level":"info","ts":"2026-10-19T02:47:31.562016Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25546,"took":"172.698655ms","hash":3043902096,"current-db-size-bytes":57552896,"current-db-size":"58 MB","current-db-size-in-use-bytes":36192256,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-19T02:47:31.56211Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3043902096,"revision":25546,"compact-revision":22128} {"level":"info","ts":"2026-10-19T02:49:02.498143Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:49:02.505447Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-19T02:49:02.505551Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-19T02:52:31.391721Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28411} {"level":"info","ts":"2026-10-19T02:52:31.541945Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28411,"took":"146.124377ms","hash":3012832186,"current-db-size-bytes":57552896,"current-db-size":"58 MB","current-db-size-in-use-bytes":30814208,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:52:31.542025Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3012832186,"revision":28411,"compact-revision":25546} {"level":"info","ts":"2026-10-19T02:57:31.400432Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30635} {"level":"info","ts":"2026-10-19T02:57:31.522334Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30635,"took":"118.020552ms","hash":3460738098,"current-db-size-bytes":57552896,"current-db-size":"58 MB","current-db-size-in-use-bytes":31154176,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:57:31.522403Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3460738098,"revision":30635,"compact-revision":28411} {"level":"info","ts":"2026-10-19T03:01:52.497904Z","caller":"traceutil/trace.go:171","msg":"trace[1174181256] transaction","detail":"{read_only:false; response_revision:34957; number_of_response:1; }","duration":"106.215196ms","start":"2026-10-19T03:01:52.391666Z","end":"2026-10-19T03:01:52.497881Z","steps":["trace[1174181256] 'process raft request' (duration: 106.019541ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T03:02:31.406891Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32889} {"level":"info","ts":"2026-10-19T03:02:31.571493Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32889,"took":"160.261151ms","hash":3438089952,"current-db-size-bytes":57552896,"current-db-size":"58 MB","current-db-size-in-use-bytes":31318016,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T03:02:31.571568Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3438089952,"revision":32889,"compact-revision":30635} {"level":"info","ts":"2026-10-19T03:07:31.414909Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35253} {"level":"info","ts":"2026-10-19T03:07:31.567164Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35253,"took":"147.670868ms","hash":1203880430,"current-db-size-bytes":57552896,"current-db-size":"58 MB","current-db-size-in-use-bytes":32010240,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T03:07:31.567227Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1203880430,"revision":35253,"compact-revision":32889} {"level":"info","ts":"2026-10-19T03:10:15.669891Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T03:10:15.676341Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-19T03:10:15.67672Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-19T03:12:31.425904Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37515} {"level":"info","ts":"2026-10-19T03:12:31.566486Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37515,"took":"134.878506ms","hash":2854806581,"current-db-size-bytes":57974784,"current-db-size":"58 MB","current-db-size-in-use-bytes":33161216,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-19T03:12:31.566558Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2854806581,"revision":37515,"compact-revision":35253}