{"level":"warn","ts":"2026-06-10T01:16:50.946701Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T01:16:50.946778Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-10T01:16:50.946841Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T01:16:50.946854Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-06-10T01:16:50.94687Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T01:16:50.947459Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-06-10T01:16:50.947524Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-10T01:16:50.95189Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.146795ms"} {"level":"info","ts":"2026-06-10T01:16:50.965541Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-06-10T01:16:50.965635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T01:16:50.965667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-06-10T01:16:50.965681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T01:16:50.965694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-06-10T01:16:50.965738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-06-10T01:16:50.981662Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T01:16:50.986493Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T01:16:50.98775Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-10T01:16:50.989974Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T01:16:50.990143Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T01:16:50.990384Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T01:16:50.99048Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T01:16:50.990501Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T01:16:50.99123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-06-10T01:16:50.991415Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-06-10T01:16:50.992588Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T01:16:50.992752Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-06-10T01:16:50.992822Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-06-10T01:16:50.992843Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T01:16:50.992893Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T01:16:51.066486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T01:16:51.066597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T01:16:51.066638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-06-10T01:16:51.066658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-06-10T01:16:51.06667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-06-10T01:16:51.066687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-06-10T01:16:51.0667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-06-10T01:16:51.067718Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T01:16:51.067745Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T01:16:51.067737Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T01:16:51.067784Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T01:16:51.068483Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T01:16:51.068568Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T01:16:51.068588Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T01:16:51.068697Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T01:16:51.068752Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T01:16:51.071408Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-06-10T01:16:51.072067Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T01:17:06.504431Z","caller":"traceutil/trace.go:171","msg":"trace[687800538] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"148.949372ms","start":"2026-06-10T01:17:06.355439Z","end":"2026-06-10T01:17:06.504388Z","steps":["trace[687800538] 'process raft request' (duration: 148.789019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:17:06.960874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.684584ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T01:17:06.961089Z","caller":"traceutil/trace.go:171","msg":"trace[488851094] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"338.287189ms","start":"2026-06-10T01:17:06.622785Z","end":"2026-06-10T01:17:06.961073Z","steps":["trace[488851094] 'process raft request' (duration: 338.219048ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:17:06.961071Z","caller":"traceutil/trace.go:171","msg":"trace[1450235959] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"445.122141ms","start":"2026-06-10T01:17:06.515915Z","end":"2026-06-10T01:17:06.961037Z","steps":["trace[1450235959] 'process raft request' (duration: 279.544909ms)","trace[1450235959] 'compare' (duration: 164.534122ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:17:06.961127Z","caller":"traceutil/trace.go:171","msg":"trace[1666800692] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:379; }","duration":"426.959432ms","start":"2026-06-10T01:17:06.534138Z","end":"2026-06-10T01:17:06.961097Z","steps":["trace[1666800692] 'read index received' (duration: 261.41809ms)","trace[1666800692] 'applied index is now lower than readState.Index' (duration: 165.539072ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:17:06.961161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:17:06.62274Z","time spent":"338.387491ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:17:06.961275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.126386ms","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-06-10T01:17:06.961304Z","caller":"traceutil/trace.go:171","msg":"trace[1993720420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:366; }","duration":"427.215568ms","start":"2026-06-10T01:17:06.534082Z","end":"2026-06-10T01:17:06.961297Z","steps":["trace[1993720420] 'agreement among raft nodes before linearized reading' (duration: 427.107366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:17:06.96133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:17:06.53406Z","time spent":"427.264938ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T01:17:06.961387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:17:06.515901Z","time spent":"445.313557ms","remote":"127.0.0.1:40992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T01:17:29.412307Z","caller":"traceutil/trace.go:171","msg":"trace[373008587] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:505; }","duration":"267.206289ms","start":"2026-06-10T01:17:29.145078Z","end":"2026-06-10T01:17:29.412284Z","steps":["trace[373008587] 'read index received' (duration: 266.958194ms)","trace[373008587] 'applied index is now lower than readState.Index' (duration: 247.195µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:17:29.412384Z","caller":"traceutil/trace.go:171","msg":"trace[663538817] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"268.898502ms","start":"2026-06-10T01:17:29.143451Z","end":"2026-06-10T01:17:29.412349Z","steps":["trace[663538817] 'process raft request' (duration: 268.652557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:17:29.412468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.368502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T01:17:29.412527Z","caller":"traceutil/trace.go:171","msg":"trace[1530842593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:486; }","duration":"267.467124ms","start":"2026-06-10T01:17:29.145045Z","end":"2026-06-10T01:17:29.412512Z","steps":["trace[1530842593] 'agreement among raft nodes before linearized reading' (duration: 267.347772ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:17:29.412541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.721907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:17:29.412585Z","caller":"traceutil/trace.go:171","msg":"trace[923517323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"197.812419ms","start":"2026-06-10T01:17:29.214758Z","end":"2026-06-10T01:17:29.41257Z","steps":["trace[923517323] 'agreement among raft nodes before linearized reading' (duration: 197.738707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:17:29.41289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.328991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:17:29.412926Z","caller":"traceutil/trace.go:171","msg":"trace[820315418] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:486; }","duration":"236.392821ms","start":"2026-06-10T01:17:29.176522Z","end":"2026-06-10T01:17:29.412915Z","steps":["trace[820315418] 'agreement among raft nodes before linearized reading' (duration: 235.922352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:17:35.535149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.637705ms","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-06-10T01:17:35.535238Z","caller":"traceutil/trace.go:171","msg":"trace[808239160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:591; }","duration":"101.774298ms","start":"2026-06-10T01:17:35.433443Z","end":"2026-06-10T01:17:35.535218Z","steps":["trace[808239160] 'range keys from in-memory index tree' (duration: 101.524912ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:17:35.782383Z","caller":"traceutil/trace.go:171","msg":"trace[459186933] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"109.684658ms","start":"2026-06-10T01:17:35.672672Z","end":"2026-06-10T01:17:35.782357Z","steps":["trace[459186933] 'process raft request' (duration: 109.041505ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:17:36.256039Z","caller":"traceutil/trace.go:171","msg":"trace[731106136] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"268.84526ms","start":"2026-06-10T01:17:35.987167Z","end":"2026-06-10T01:17:36.256012Z","steps":["trace[731106136] 'read index received' (duration: 268.740208ms)","trace[731106136] 'applied index is now lower than readState.Index' (duration: 104.022µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:17:36.256154Z","caller":"traceutil/trace.go:171","msg":"trace[1948925060] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"407.716312ms","start":"2026-06-10T01:17:35.848394Z","end":"2026-06-10T01:17:36.25611Z","steps":["trace[1948925060] 'process raft request' (duration: 407.463647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:17:36.256309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:17:35.848364Z","time spent":"407.876196ms","remote":"127.0.0.1:41328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T01:17:36.256335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.141827ms","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-06-10T01:17:36.256432Z","caller":"traceutil/trace.go:171","msg":"trace[804827676] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"269.287749ms","start":"2026-06-10T01:17:35.987122Z","end":"2026-06-10T01:17:36.25641Z","steps":["trace[804827676] 'agreement among raft nodes before linearized reading' (duration: 269.019104ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:17:40.752873Z","caller":"traceutil/trace.go:171","msg":"trace[1951449372] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"139.473243ms","start":"2026-06-10T01:17:40.612924Z","end":"2026-06-10T01:17:40.752398Z","steps":["trace[1951449372] 'process raft request' (duration: 133.768417ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:19:01.948105Z","caller":"traceutil/trace.go:171","msg":"trace[1558811294] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"115.073072ms","start":"2026-06-10T01:19:01.832992Z","end":"2026-06-10T01:19:01.948065Z","steps":["trace[1558811294] 'process raft request' (duration: 73.628039ms)","trace[1558811294] 'compare' (duration: 41.204569ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:19:14.5817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.056087ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T01:19:14.582034Z","caller":"traceutil/trace.go:171","msg":"trace[1234557181] linearizableReadLoop","detail":"{readStateIndex:1988; appliedIndex:1986; }","duration":"240.136388ms","start":"2026-06-10T01:19:14.341881Z","end":"2026-06-10T01:19:14.582017Z","steps":["trace[1234557181] 'read index received' (duration: 109.660203ms)","trace[1234557181] 'applied index is now lower than readState.Index' (duration: 130.470575ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:19:14.582001Z","caller":"traceutil/trace.go:171","msg":"trace[1789561810] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"340.637453ms","start":"2026-06-10T01:19:14.241317Z","end":"2026-06-10T01:19:14.581955Z","steps":["trace[1789561810] 'process raft request' (duration: 210.244539ms)","trace[1789561810] 'compare' (duration: 129.760451ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:19:14.582026Z","caller":"traceutil/trace.go:171","msg":"trace[1518489939] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"340.568531ms","start":"2026-06-10T01:19:14.241408Z","end":"2026-06-10T01:19:14.581977Z","steps":["trace[1518489939] 'process raft request' (duration: 340.429839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:19:14.582209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.313472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T01:19:14.582228Z","caller":"traceutil/trace.go:171","msg":"trace[217705820] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1918; }","duration":"240.384703ms","start":"2026-06-10T01:19:14.341838Z","end":"2026-06-10T01:19:14.582223Z","steps":["trace[217705820] 'agreement among raft nodes before linearized reading' (duration: 240.300242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:19:14.58221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:19:14.241308Z","time spent":"340.812206ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:19:14.582298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:19:14.241387Z","time spent":"340.754906ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:19:14.582376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.885411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T01:19:14.582564Z","caller":"traceutil/trace.go:171","msg":"trace[1060801721] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:1918; }","duration":"209.087736ms","start":"2026-06-10T01:19:14.37345Z","end":"2026-06-10T01:19:14.582538Z","steps":["trace[1060801721] 'agreement among raft nodes before linearized reading' (duration: 208.720828ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:21:25.253768Z","caller":"traceutil/trace.go:171","msg":"trace[775396433] transaction","detail":"{read_only:false; response_revision:2821; number_of_response:1; }","duration":"122.473499ms","start":"2026-06-10T01:21:25.131266Z","end":"2026-06-10T01:21:25.25374Z","steps":["trace[775396433] 'process raft request' (duration: 122.220244ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:21:25.455378Z","caller":"traceutil/trace.go:171","msg":"trace[1735713874] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"158.601086ms","start":"2026-06-10T01:21:25.296733Z","end":"2026-06-10T01:21:25.455334Z","steps":["trace[1735713874] 'process raft request' (duration: 115.507226ms)","trace[1735713874] 'compare' (duration: 42.833444ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:23:55.702348Z","caller":"traceutil/trace.go:171","msg":"trace[732733648] transaction","detail":"{read_only:false; response_revision:3822; number_of_response:1; }","duration":"123.758941ms","start":"2026-06-10T01:23:55.578561Z","end":"2026-06-10T01:23:55.70232Z","steps":["trace[732733648] 'process raft request' (duration: 123.616408ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:25:26.088569Z","caller":"traceutil/trace.go:171","msg":"trace[538232733] linearizableReadLoop","detail":"{readStateIndex:5084; appliedIndex:5083; }","duration":"107.995622ms","start":"2026-06-10T01:25:25.980546Z","end":"2026-06-10T01:25:26.088542Z","steps":["trace[538232733] 'read index received' (duration: 107.770148ms)","trace[538232733] 'applied index is now lower than readState.Index' (duration: 224.224µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:25:26.088679Z","caller":"traceutil/trace.go:171","msg":"trace[632934198] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"113.25804ms","start":"2026-06-10T01:25:25.97538Z","end":"2026-06-10T01:25:26.088638Z","steps":["trace[632934198] 'process raft request' (duration: 112.967254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:25:26.088871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.286918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11455"} {"level":"info","ts":"2026-06-10T01:25:26.08894Z","caller":"traceutil/trace.go:171","msg":"trace[1352467498] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4896; }","duration":"108.410521ms","start":"2026-06-10T01:25:25.980511Z","end":"2026-06-10T01:25:26.088922Z","steps":["trace[1352467498] 'agreement among raft nodes before linearized reading' (duration: 108.150886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:25:50.651974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.533762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-edb9708c-6068-4404-a5cf-8b2482dd84ef\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-10T01:25:50.652078Z","caller":"traceutil/trace.go:171","msg":"trace[1705250182] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-edb9708c-6068-4404-a5cf-8b2482dd84ef; range_end:; response_count:1; response_revision:5457; }","duration":"100.696265ms","start":"2026-06-10T01:25:50.551359Z","end":"2026-06-10T01:25:50.652055Z","steps":["trace[1705250182] 'range keys from in-memory index tree' (duration: 100.244086ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:25:50.840118Z","caller":"traceutil/trace.go:171","msg":"trace[600070815] transaction","detail":"{read_only:false; response_revision:5459; number_of_response:1; }","duration":"102.840619ms","start":"2026-06-10T01:25:50.737242Z","end":"2026-06-10T01:25:50.840083Z","steps":["trace[600070815] 'process raft request' (duration: 41.35685ms)","trace[600070815] 'compare' (duration: 61.331636ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:25:50.998995Z","caller":"traceutil/trace.go:171","msg":"trace[379512021] transaction","detail":"{read_only:false; response_revision:5460; number_of_response:1; }","duration":"140.976423ms","start":"2026-06-10T01:25:50.857968Z","end":"2026-06-10T01:25:50.998945Z","steps":["trace[379512021] 'process raft request' (duration: 118.575888ms)","trace[379512021] 'compare' (duration: 22.210911ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:25:51.150412Z","caller":"traceutil/trace.go:171","msg":"trace[980576277] transaction","detail":"{read_only:false; response_revision:5461; number_of_response:1; }","duration":"139.730998ms","start":"2026-06-10T01:25:51.010649Z","end":"2026-06-10T01:25:51.15038Z","steps":["trace[980576277] 'process raft request' (duration: 135.999001ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:26:51.469705Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2967} {"level":"info","ts":"2026-06-10T01:26:51.542264Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2967,"took":"71.432453ms","hash":1475331032,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":33873920,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-10T01:26:51.54233Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1475331032,"revision":2967,"compact-revision":-1} {"level":"info","ts":"2026-06-10T01:31:51.476123Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6038} {"level":"info","ts":"2026-06-10T01:31:51.567644Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6038,"took":"89.241703ms","hash":4260314499,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":23814144,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-10T01:31:51.567726Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4260314499,"revision":6038,"compact-revision":2967} {"level":"info","ts":"2026-06-10T01:31:52.442608Z","caller":"traceutil/trace.go:171","msg":"trace[121758816] transaction","detail":"{read_only:false; response_revision:8268; number_of_response:1; }","duration":"124.280305ms","start":"2026-06-10T01:31:52.318314Z","end":"2026-06-10T01:31:52.442594Z","steps":["trace[121758816] 'process raft request' (duration: 124.200624ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:31:52.612238Z","caller":"traceutil/trace.go:171","msg":"trace[307632145] linearizableReadLoop","detail":"{readStateIndex:8561; appliedIndex:8560; }","duration":"144.530225ms","start":"2026-06-10T01:31:52.467675Z","end":"2026-06-10T01:31:52.612205Z","steps":["trace[307632145] 'read index received' (duration: 67.668764ms)","trace[307632145] 'applied index is now lower than readState.Index' (duration: 76.860441ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:31:52.61234Z","caller":"traceutil/trace.go:171","msg":"trace[93094792] transaction","detail":"{read_only:false; response_revision:8269; number_of_response:1; }","duration":"292.133974ms","start":"2026-06-10T01:31:52.320172Z","end":"2026-06-10T01:31:52.612306Z","steps":["trace[93094792] 'process raft request' (duration: 215.184462ms)","trace[93094792] 'compare' (duration: 76.684867ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:31:52.612522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.830142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-10T01:31:52.612613Z","caller":"traceutil/trace.go:171","msg":"trace[1902693521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8269; }","duration":"144.968424ms","start":"2026-06-10T01:31:52.467624Z","end":"2026-06-10T01:31:52.612592Z","steps":["trace[1902693521] 'agreement among raft nodes before linearized reading' (duration: 144.727849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:04.029076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.326239ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T01:32:04.029153Z","caller":"traceutil/trace.go:171","msg":"trace[180327488] linearizableReadLoop","detail":"{readStateIndex:8623; appliedIndex:8622; }","duration":"153.760454ms","start":"2026-06-10T01:32:03.875381Z","end":"2026-06-10T01:32:04.029141Z","steps":["trace[180327488] 'read index received' (duration: 21.247091ms)","trace[180327488] 'applied index is now lower than readState.Index' (duration: 132.512653ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:32:04.02932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.949107ms","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-06-10T01:32:04.02934Z","caller":"traceutil/trace.go:171","msg":"trace[164677182] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8328; }","duration":"154.005388ms","start":"2026-06-10T01:32:03.875328Z","end":"2026-06-10T01:32:04.029333Z","steps":["trace[164677182] 'agreement among raft nodes before linearized reading' (duration: 153.841125ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:32:04.02955Z","caller":"traceutil/trace.go:171","msg":"trace[359963973] transaction","detail":"{read_only:false; response_revision:8328; number_of_response:1; }","duration":"278.023709ms","start":"2026-06-10T01:32:03.751323Z","end":"2026-06-10T01:32:04.029346Z","steps":["trace[359963973] 'process raft request' (duration: 145.357153ms)","trace[359963973] 'compare' (duration: 132.241737ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:32:04.879835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.429449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-10T01:32:04.879931Z","caller":"traceutil/trace.go:171","msg":"trace[1378065587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8333; }","duration":"192.584712ms","start":"2026-06-10T01:32:04.687326Z","end":"2026-06-10T01:32:04.879911Z","steps":["trace[1378065587] 'range keys from in-memory index tree' (duration: 192.214114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:04.879945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.753267ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:32:04.88005Z","caller":"traceutil/trace.go:171","msg":"trace[879234355] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8333; }","duration":"100.871629ms","start":"2026-06-10T01:32:04.779162Z","end":"2026-06-10T01:32:04.880033Z","steps":["trace[879234355] 'range keys from in-memory index tree' (duration: 100.736197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:04.880037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.266082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-10T01:32:04.880121Z","caller":"traceutil/trace.go:171","msg":"trace[1550028378] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8333; }","duration":"212.405635ms","start":"2026-06-10T01:32:04.667696Z","end":"2026-06-10T01:32:04.880102Z","steps":["trace[1550028378] 'range keys from in-memory index tree' (duration: 212.051357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:04.880096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.380069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-10T01:32:04.880246Z","caller":"traceutil/trace.go:171","msg":"trace[1820089360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8333; }","duration":"194.581573ms","start":"2026-06-10T01:32:04.685642Z","end":"2026-06-10T01:32:04.880224Z","steps":["trace[1820089360] 'range keys from in-memory index tree' (duration: 194.169185ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:32:32.978546Z","caller":"traceutil/trace.go:171","msg":"trace[1851062310] linearizableReadLoop","detail":"{readStateIndex:8839; appliedIndex:8838; }","duration":"278.333025ms","start":"2026-06-10T01:32:32.700189Z","end":"2026-06-10T01:32:32.978522Z","steps":["trace[1851062310] 'read index received' (duration: 278.145371ms)","trace[1851062310] 'applied index is now lower than readState.Index' (duration: 186.534µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:32:32.978756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.54642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T01:32:32.978801Z","caller":"traceutil/trace.go:171","msg":"trace[206272983] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:8536; }","duration":"278.657361ms","start":"2026-06-10T01:32:32.700133Z","end":"2026-06-10T01:32:32.97879Z","steps":["trace[206272983] 'agreement among raft nodes before linearized reading' (duration: 278.499658ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:32:32.978857Z","caller":"traceutil/trace.go:171","msg":"trace[1956383550] transaction","detail":"{read_only:false; response_revision:8536; number_of_response:1; }","duration":"302.364533ms","start":"2026-06-10T01:32:32.676465Z","end":"2026-06-10T01:32:32.978829Z","steps":["trace[1956383550] 'process raft request' (duration: 301.887974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:32.97901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:32:32.676455Z","time spent":"302.477465ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T01:32:34.825032Z","caller":"traceutil/trace.go:171","msg":"trace[791137456] transaction","detail":"{read_only:false; response_revision:8548; number_of_response:1; }","duration":"207.521176ms","start":"2026-06-10T01:32:34.617462Z","end":"2026-06-10T01:32:34.824984Z","steps":["trace[791137456] 'process raft request' (duration: 188.713294ms)","trace[791137456] 'compare' (duration: 18.497936ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:32:35.569774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.347052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-10T01:32:35.5699Z","caller":"traceutil/trace.go:171","msg":"trace[194177511] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:8554; }","duration":"172.559206ms","start":"2026-06-10T01:32:35.397316Z","end":"2026-06-10T01:32:35.569875Z","steps":["trace[194177511] 'range keys from in-memory index tree' (duration: 172.061716ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:32:45.76675Z","caller":"traceutil/trace.go:171","msg":"trace[2049513782] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"119.830244ms","start":"2026-06-10T01:32:45.646892Z","end":"2026-06-10T01:32:45.766723Z","steps":["trace[2049513782] 'process raft request' (duration: 119.659451ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:33:02.412093Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023a4.wal"} {"level":"info","ts":"2026-06-10T01:34:35.666933Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e46287fb5aa4785","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T01:34:35.674259Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-10T01:34:35.674343Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-10T01:36:51.482824Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8265} {"level":"info","ts":"2026-06-10T01:36:51.564622Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8265,"took":"79.201619ms","hash":1765155190,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":26415104,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-10T01:36:51.564703Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1765155190,"revision":8265,"compact-revision":6038} {"level":"info","ts":"2026-06-10T01:37:22.847316Z","caller":"traceutil/trace.go:171","msg":"trace[985373291] transaction","detail":"{read_only:false; response_revision:11119; number_of_response:1; }","duration":"122.987133ms","start":"2026-06-10T01:37:22.724302Z","end":"2026-06-10T01:37:22.847289Z","steps":["trace[985373291] 'process raft request' (duration: 122.879431ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:37:22.847356Z","caller":"traceutil/trace.go:171","msg":"trace[61542456] transaction","detail":"{read_only:false; response_revision:11118; number_of_response:1; }","duration":"123.506193ms","start":"2026-06-10T01:37:22.723818Z","end":"2026-06-10T01:37:22.847325Z","steps":["trace[61542456] 'process raft request' (duration: 76.264459ms)","trace[61542456] 'compare' (duration: 46.930167ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:41:51.488887Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10751} {"level":"info","ts":"2026-06-10T01:41:51.576689Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10751,"took":"85.102031ms","hash":2281849661,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":27226112,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-10T01:41:51.576798Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2281849661,"revision":10751,"compact-revision":8265} {"level":"info","ts":"2026-06-10T01:43:28.079063Z","caller":"traceutil/trace.go:171","msg":"trace[1209149223] transaction","detail":"{read_only:false; response_revision:13599; number_of_response:1; }","duration":"112.93064ms","start":"2026-06-10T01:43:27.966098Z","end":"2026-06-10T01:43:28.079029Z","steps":["trace[1209149223] 'process raft request' (duration: 112.712286ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:44:03.189698Z","caller":"traceutil/trace.go:171","msg":"trace[1060360052] linearizableReadLoop","detail":"{readStateIndex:14272; appliedIndex:14271; }","duration":"232.158697ms","start":"2026-06-10T01:44:02.957511Z","end":"2026-06-10T01:44:03.189669Z","steps":["trace[1060360052] 'read index received' (duration: 228.29732ms)","trace[1060360052] 'applied index is now lower than readState.Index' (duration: 3.860187ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:44:03.189771Z","caller":"traceutil/trace.go:171","msg":"trace[157915874] transaction","detail":"{read_only:false; response_revision:13800; number_of_response:1; }","duration":"235.466955ms","start":"2026-06-10T01:44:02.954264Z","end":"2026-06-10T01:44:03.189731Z","steps":["trace[157915874] 'process raft request' (duration: 231.531866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:44:03.190032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.498595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-10T01:44:03.190085Z","caller":"traceutil/trace.go:171","msg":"trace[78295229] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13800; }","duration":"232.581607ms","start":"2026-06-10T01:44:02.957485Z","end":"2026-06-10T01:44:03.190067Z","steps":["trace[78295229] 'agreement among raft nodes before linearized reading' (duration: 232.364133ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:44:03.373604Z","caller":"traceutil/trace.go:171","msg":"trace[2051842346] transaction","detail":"{read_only:false; response_revision:13801; number_of_response:1; }","duration":"179.627702ms","start":"2026-06-10T01:44:03.193951Z","end":"2026-06-10T01:44:03.373578Z","steps":["trace[2051842346] 'process raft request' (duration: 179.466519ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:44:03.383171Z","caller":"traceutil/trace.go:171","msg":"trace[964244058] transaction","detail":"{read_only:false; response_revision:13802; number_of_response:1; }","duration":"182.336988ms","start":"2026-06-10T01:44:03.200806Z","end":"2026-06-10T01:44:03.383143Z","steps":["trace[964244058] 'process raft request' (duration: 182.187105ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:44:12.58209Z","caller":"traceutil/trace.go:171","msg":"trace[100126850] linearizableReadLoop","detail":"{readStateIndex:14444; appliedIndex:14443; }","duration":"102.608873ms","start":"2026-06-10T01:44:12.479413Z","end":"2026-06-10T01:44:12.582022Z","steps":["trace[100126850] 'read index received' (duration: 102.305507ms)","trace[100126850] 'applied index is now lower than readState.Index' (duration: 301.526µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:44:12.582298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.860638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T01:44:12.582157Z","caller":"traceutil/trace.go:171","msg":"trace[1969712021] transaction","detail":"{read_only:false; response_revision:13969; number_of_response:1; }","duration":"264.930467ms","start":"2026-06-10T01:44:12.317186Z","end":"2026-06-10T01:44:12.582116Z","steps":["trace[1969712021] 'process raft request' (duration: 264.56356ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:44:12.58239Z","caller":"traceutil/trace.go:171","msg":"trace[2108980929] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:13969; }","duration":"103.008041ms","start":"2026-06-10T01:44:12.479363Z","end":"2026-06-10T01:44:12.582371Z","steps":["trace[2108980929] 'agreement among raft nodes before linearized reading' (duration: 102.842388ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:46:16.637335Z","caller":"traceutil/trace.go:171","msg":"trace[1010926522] transaction","detail":"{read_only:false; response_revision:15184; number_of_response:1; }","duration":"182.553927ms","start":"2026-06-10T01:46:16.454752Z","end":"2026-06-10T01:46:16.637306Z","steps":["trace[1010926522] 'process raft request' (duration: 182.261302ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:46:17.017019Z","caller":"traceutil/trace.go:171","msg":"trace[1068464689] linearizableReadLoop","detail":"{readStateIndex:15700; appliedIndex:15699; }","duration":"333.314017ms","start":"2026-06-10T01:46:16.683675Z","end":"2026-06-10T01:46:17.016989Z","steps":["trace[1068464689] 'read index received' (duration: 333.187835ms)","trace[1068464689] 'applied index is now lower than readState.Index' (duration: 125.242µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:46:17.017087Z","caller":"traceutil/trace.go:171","msg":"trace[109899838] transaction","detail":"{read_only:false; response_revision:15185; number_of_response:1; }","duration":"373.84113ms","start":"2026-06-10T01:46:16.643206Z","end":"2026-06-10T01:46:17.017047Z","steps":["trace[109899838] 'process raft request' (duration: 373.644466ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:46:17.017162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.477801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:46:17.017203Z","caller":"traceutil/trace.go:171","msg":"trace[941791841] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15185; }","duration":"333.560532ms","start":"2026-06-10T01:46:16.683633Z","end":"2026-06-10T01:46:17.017193Z","steps":["trace[941791841] 'agreement among raft nodes before linearized reading' (duration: 333.481951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:46:17.017385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:46:16.683614Z","time spent":"333.757227ms","remote":"127.0.0.1:41042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-06-10T01:46:17.017353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:46:16.643195Z","time spent":"373.969703ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:46:17.06389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.462572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-06-10T01:46:17.063994Z","caller":"traceutil/trace.go:171","msg":"trace[831777428] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15186; }","duration":"379.610825ms","start":"2026-06-10T01:46:16.684364Z","end":"2026-06-10T01:46:17.063975Z","steps":["trace[831777428] 'agreement among raft nodes before linearized reading' (duration: 379.3519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:46:17.064045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:46:16.684348Z","time spent":"379.681096ms","remote":"127.0.0.1:40972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-06-10T01:46:17.064036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.87421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"warn","ts":"2026-06-10T01:46:17.064032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.352274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:46:17.064027Z","caller":"traceutil/trace.go:171","msg":"trace[1982066645] transaction","detail":"{read_only:false; response_revision:15186; number_of_response:1; }","duration":"331.781276ms","start":"2026-06-10T01:46:16.732211Z","end":"2026-06-10T01:46:17.063992Z","steps":["trace[1982066645] 'process raft request' (duration: 294.131772ms)","trace[1982066645] 'compare' (duration: 37.248917ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:46:17.064085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.041858ms","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-06-10T01:46:17.064111Z","caller":"traceutil/trace.go:171","msg":"trace[921892421] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15186; }","duration":"373.965112ms","start":"2026-06-10T01:46:16.690126Z","end":"2026-06-10T01:46:17.064092Z","steps":["trace[921892421] 'agreement among raft nodes before linearized reading' (duration: 373.668887ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:46:17.064123Z","caller":"traceutil/trace.go:171","msg":"trace[221209975] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:15186; }","duration":"212.496887ms","start":"2026-06-10T01:46:16.851608Z","end":"2026-06-10T01:46:17.064104Z","steps":["trace[221209975] 'agreement among raft nodes before linearized reading' (duration: 212.342084ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:46:17.064158Z","caller":"traceutil/trace.go:171","msg":"trace[36448665] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15186; }","duration":"200.13595ms","start":"2026-06-10T01:46:16.864002Z","end":"2026-06-10T01:46:17.064138Z","steps":["trace[36448665] 'agreement among raft nodes before linearized reading' (duration: 199.974386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:46:17.063887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.519406ms","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-06-10T01:46:17.06416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:46:16.690119Z","time spent":"374.030054ms","remote":"127.0.0.1:41042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5546,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-06-10T01:46:17.064215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:46:16.732192Z","time spent":"331.932011ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T01:46:17.064242Z","caller":"traceutil/trace.go:171","msg":"trace[179162677] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15186; }","duration":"212.917566ms","start":"2026-06-10T01:46:16.851295Z","end":"2026-06-10T01:46:17.064213Z","steps":["trace[179162677] 'agreement among raft nodes before linearized reading' (duration: 212.475036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:46:17.064466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.963647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:681"} {"level":"info","ts":"2026-06-10T01:46:17.064599Z","caller":"traceutil/trace.go:171","msg":"trace[976316940] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:15186; }","duration":"212.139741ms","start":"2026-06-10T01:46:16.85244Z","end":"2026-06-10T01:46:17.06458Z","steps":["trace[976316940] 'agreement among raft nodes before linearized reading' (duration: 211.733103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:46:17.064807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.986687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-06-10T01:46:17.064876Z","caller":"traceutil/trace.go:171","msg":"trace[732838201] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15186; }","duration":"213.075928ms","start":"2026-06-10T01:46:16.851784Z","end":"2026-06-10T01:46:17.06486Z","steps":["trace[732838201] 'agreement among raft nodes before linearized reading' (duration: 212.532208ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:46:51.494951Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12842} {"level":"info","ts":"2026-06-10T01:46:51.574148Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12842,"took":"75.950102ms","hash":3932097914,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":29696000,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T01:46:51.574221Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3932097914,"revision":12842,"compact-revision":10751} {"level":"info","ts":"2026-06-10T01:51:30.114851Z","caller":"traceutil/trace.go:171","msg":"trace[1245059597] transaction","detail":"{read_only:false; response_revision:17506; number_of_response:1; }","duration":"191.900772ms","start":"2026-06-10T01:51:29.922919Z","end":"2026-06-10T01:51:30.11482Z","steps":["trace[1245059597] 'process raft request' (duration: 191.645747ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:51:37.100947Z","caller":"traceutil/trace.go:171","msg":"trace[1484008055] transaction","detail":"{read_only:false; response_revision:17552; number_of_response:1; }","duration":"210.433842ms","start":"2026-06-10T01:51:36.890462Z","end":"2026-06-10T01:51:37.100896Z","steps":["trace[1484008055] 'process raft request' (duration: 150.105634ms)","trace[1484008055] 'compare' (duration: 59.666984ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:51:37.955138Z","caller":"traceutil/trace.go:171","msg":"trace[948367931] transaction","detail":"{read_only:false; response_revision:17556; number_of_response:1; }","duration":"162.841111ms","start":"2026-06-10T01:51:37.792255Z","end":"2026-06-10T01:51:37.955096Z","steps":["trace[948367931] 'process raft request' (duration: 162.599765ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:51:51.500973Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15362} {"level":"info","ts":"2026-06-10T01:51:51.596399Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15362,"took":"92.378999ms","hash":3954913482,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":31825920,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T01:51:51.596452Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3954913482,"revision":15362,"compact-revision":12842} {"level":"info","ts":"2026-06-10T01:54:14.390259Z","caller":"traceutil/trace.go:171","msg":"trace[288850296] linearizableReadLoop","detail":"{readStateIndex:19562; appliedIndex:19560; }","duration":"354.247258ms","start":"2026-06-10T01:54:14.03599Z","end":"2026-06-10T01:54:14.390238Z","steps":["trace[288850296] 'read index received' (duration: 351.441222ms)","trace[288850296] 'applied index is now lower than readState.Index' (duration: 2.805396ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:54:14.390496Z","caller":"traceutil/trace.go:171","msg":"trace[263545097] transaction","detail":"{read_only:false; response_revision:18924; number_of_response:1; }","duration":"549.578465ms","start":"2026-06-10T01:54:13.840899Z","end":"2026-06-10T01:54:14.390478Z","steps":["trace[263545097] 'process raft request' (duration: 549.267089ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:54:14.390471Z","caller":"traceutil/trace.go:171","msg":"trace[1354353559] transaction","detail":"{read_only:false; response_revision:18923; number_of_response:1; }","duration":"608.55092ms","start":"2026-06-10T01:54:13.781881Z","end":"2026-06-10T01:54:14.390432Z","steps":["trace[1354353559] 'process raft request' (duration: 605.57631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:54:14.390648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:54:13.781848Z","time spent":"608.722753ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:54:14.391586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.546672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T01:54:14.391671Z","caller":"traceutil/trace.go:171","msg":"trace[658282625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18924; }","duration":"311.631183ms","start":"2026-06-10T01:54:14.079992Z","end":"2026-06-10T01:54:14.391623Z","steps":["trace[658282625] 'agreement among raft nodes before linearized reading' (duration: 311.284475ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:54:14.391712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:54:14.079974Z","time spent":"311.726156ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T01:54:14.391983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.000304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T01:54:14.392012Z","caller":"traceutil/trace.go:171","msg":"trace[1187345148] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18924; }","duration":"356.067736ms","start":"2026-06-10T01:54:14.035935Z","end":"2026-06-10T01:54:14.392003Z","steps":["trace[1187345148] 'agreement among raft nodes before linearized reading' (duration: 355.970494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:54:14.3921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:54:14.035914Z","time spent":"356.177067ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T01:54:14.393652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:54:13.840874Z","time spent":"549.666846ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T01:55:16.840951Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e46287fb5aa4785","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T01:55:16.845824Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-10T01:55:16.845943Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-10T01:56:49.631064Z","caller":"traceutil/trace.go:171","msg":"trace[1838706445] transaction","detail":"{read_only:false; response_revision:20086; number_of_response:1; }","duration":"231.385519ms","start":"2026-06-10T01:56:49.399645Z","end":"2026-06-10T01:56:49.631031Z","steps":["trace[1838706445] 'process raft request' (duration: 228.540152ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:56:49.674312Z","caller":"traceutil/trace.go:171","msg":"trace[724993712] linearizableReadLoop","detail":"{readStateIndex:20765; appliedIndex:20763; }","duration":"223.59003ms","start":"2026-06-10T01:56:49.450699Z","end":"2026-06-10T01:56:49.674289Z","steps":["trace[724993712] 'read index received' (duration: 177.403284ms)","trace[724993712] 'applied index is now lower than readState.Index' (duration: 46.185996ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:56:49.674492Z","caller":"traceutil/trace.go:171","msg":"trace[55562546] transaction","detail":"{read_only:false; response_revision:20087; number_of_response:1; }","duration":"236.359998ms","start":"2026-06-10T01:56:49.438126Z","end":"2026-06-10T01:56:49.674486Z","steps":["trace[55562546] 'process raft request' (duration: 236.065532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:56:49.67476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.05802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T01:56:49.674797Z","caller":"traceutil/trace.go:171","msg":"trace[914281888] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20087; }","duration":"224.108031ms","start":"2026-06-10T01:56:49.450682Z","end":"2026-06-10T01:56:49.67479Z","steps":["trace[914281888] 'agreement among raft nodes before linearized reading' (duration: 223.992379ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:56:51.512196Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17716} {"level":"info","ts":"2026-06-10T01:56:51.742598Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17716,"took":"226.759747ms","hash":4089425271,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":34004992,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-10T01:56:51.742678Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4089425271,"revision":17716,"compact-revision":15362} {"level":"info","ts":"2026-06-10T01:57:17.786628Z","caller":"traceutil/trace.go:171","msg":"trace[1602336691] transaction","detail":"{read_only:false; response_revision:20227; number_of_response:1; }","duration":"434.913396ms","start":"2026-06-10T01:57:17.351685Z","end":"2026-06-10T01:57:17.786598Z","steps":["trace[1602336691] 'process raft request' (duration: 434.63297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:17.786787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:17.351667Z","time spent":"435.028779ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:57:17.786936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.753168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-10T01:57:17.787007Z","caller":"traceutil/trace.go:171","msg":"trace[254290252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20227; }","duration":"402.888011ms","start":"2026-06-10T01:57:17.384101Z","end":"2026-06-10T01:57:17.786989Z","steps":["trace[254290252] 'agreement among raft nodes before linearized reading' (duration: 402.585375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:17.787151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:17.384082Z","time spent":"403.013253ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T01:57:17.786578Z","caller":"traceutil/trace.go:171","msg":"trace[325976176] linearizableReadLoop","detail":"{readStateIndex:20912; appliedIndex:20911; }","duration":"402.38776ms","start":"2026-06-10T01:57:17.384165Z","end":"2026-06-10T01:57:17.786553Z","steps":["trace[325976176] 'read index received' (duration: 402.231307ms)","trace[325976176] 'applied index is now lower than readState.Index' (duration: 155.653µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:57:17.89431Z","caller":"traceutil/trace.go:171","msg":"trace[699023630] linearizableReadLoop","detail":"{readStateIndex:20913; appliedIndex:20912; }","duration":"106.54542ms","start":"2026-06-10T01:57:17.787728Z","end":"2026-06-10T01:57:17.894274Z","steps":["trace[699023630] 'read index received' (duration: 79.659818ms)","trace[699023630] 'applied index is now lower than readState.Index' (duration: 26.884062ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:57:17.894382Z","caller":"traceutil/trace.go:171","msg":"trace[1686327008] transaction","detail":"{read_only:false; response_revision:20228; number_of_response:1; }","duration":"147.18769ms","start":"2026-06-10T01:57:17.747153Z","end":"2026-06-10T01:57:17.89434Z","steps":["trace[1686327008] 'process raft request' (duration: 120.220716ms)","trace[1686327008] 'compare' (duration: 26.735339ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:57:17.894574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.255812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T01:57:17.894611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.947583ms","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":"info","ts":"2026-06-10T01:57:17.894649Z","caller":"traceutil/trace.go:171","msg":"trace[481784844] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:20228; }","duration":"320.474327ms","start":"2026-06-10T01:57:17.574137Z","end":"2026-06-10T01:57:17.894611Z","steps":["trace[481784844] 'agreement among raft nodes before linearized reading' (duration: 320.195672ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:57:17.894666Z","caller":"traceutil/trace.go:171","msg":"trace[1242632361] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20228; }","duration":"470.078256ms","start":"2026-06-10T01:57:17.424569Z","end":"2026-06-10T01:57:17.894647Z","steps":["trace[1242632361] 'agreement among raft nodes before linearized reading' (duration: 469.832791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:17.894693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:17.574118Z","time spent":"320.561408ms","remote":"127.0.0.1:46524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-10T01:57:17.894717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:17.424542Z","time spent":"470.165217ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-10T01:57:17.895252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.840476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-10T01:57:17.895495Z","caller":"traceutil/trace.go:171","msg":"trace[2114996784] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:20228; }","duration":"328.715404ms","start":"2026-06-10T01:57:17.566764Z","end":"2026-06-10T01:57:17.895479Z","steps":["trace[2114996784] 'agreement among raft nodes before linearized reading' (duration: 327.647892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:17.895548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:17.56674Z","time spent":"328.793155ms","remote":"127.0.0.1:41140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":153,"response size":32,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-06-10T01:57:17.915031Z","caller":"traceutil/trace.go:171","msg":"trace[1425245786] transaction","detail":"{read_only:false; response_revision:20229; number_of_response:1; }","duration":"122.174576ms","start":"2026-06-10T01:57:17.792816Z","end":"2026-06-10T01:57:17.91499Z","steps":["trace[1425245786] 'process raft request' (duration: 121.993602ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:57:44.040785Z","caller":"traceutil/trace.go:171","msg":"trace[266613522] transaction","detail":"{read_only:false; response_revision:20363; number_of_response:1; }","duration":"106.167603ms","start":"2026-06-10T01:57:43.934591Z","end":"2026-06-10T01:57:44.040759Z","steps":["trace[266613522] 'process raft request' (duration: 105.992219ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:57:44.400604Z","caller":"traceutil/trace.go:171","msg":"trace[1214050471] transaction","detail":"{read_only:false; response_revision:20366; number_of_response:1; }","duration":"300.012474ms","start":"2026-06-10T01:57:44.100559Z","end":"2026-06-10T01:57:44.400572Z","steps":["trace[1214050471] 'process raft request' (duration: 299.79151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:44.40078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:44.100541Z","time spent":"300.145406ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:57:44.750522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.288851ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T01:57:44.750818Z","caller":"traceutil/trace.go:171","msg":"trace[1094669178] transaction","detail":"{read_only:false; response_revision:20367; number_of_response:1; }","duration":"650.136309ms","start":"2026-06-10T01:57:44.100637Z","end":"2026-06-10T01:57:44.750773Z","steps":["trace[1094669178] 'process raft request' (duration: 449.47287ms)","trace[1094669178] 'compare' (duration: 199.986716ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:57:44.750872Z","caller":"traceutil/trace.go:171","msg":"trace[1844371117] transaction","detail":"{read_only:false; response_revision:20368; number_of_response:1; }","duration":"650.085349ms","start":"2026-06-10T01:57:44.100763Z","end":"2026-06-10T01:57:44.750848Z","steps":["trace[1844371117] 'process raft request' (duration: 649.899515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:44.751005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:44.100754Z","time spent":"650.208931ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:57:44.751029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:44.100608Z","time spent":"650.312183ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T01:57:44.751228Z","caller":"traceutil/trace.go:171","msg":"trace[719895420] transaction","detail":"{read_only:false; response_revision:20369; number_of_response:1; }","duration":"598.216852ms","start":"2026-06-10T01:57:44.152947Z","end":"2026-06-10T01:57:44.751164Z","steps":["trace[719895420] 'process raft request' (duration: 597.826044ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:57:44.751328Z","caller":"traceutil/trace.go:171","msg":"trace[1568262639] linearizableReadLoop","detail":"{readStateIndex:21059; appliedIndex:21056; }","duration":"645.576517ms","start":"2026-06-10T01:57:44.105717Z","end":"2026-06-10T01:57:44.751293Z","steps":["trace[1568262639] 'read index received' (duration: 294.790429ms)","trace[1568262639] 'applied index is now lower than readState.Index' (duration: 350.778348ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:57:44.751335Z","caller":"traceutil/trace.go:171","msg":"trace[1393108177] transaction","detail":"{read_only:false; response_revision:20370; number_of_response:1; }","duration":"597.701481ms","start":"2026-06-10T01:57:44.153587Z","end":"2026-06-10T01:57:44.751289Z","steps":["trace[1393108177] 'process raft request' (duration: 597.475857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:44.751505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:44.152933Z","time spent":"598.409345ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:57:44.75156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:44.153574Z","time spent":"597.942806ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:57:44.751577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.858523ms","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-06-10T01:57:44.751626Z","caller":"traceutil/trace.go:171","msg":"trace[1086875518] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20370; }","duration":"645.930124ms","start":"2026-06-10T01:57:44.10568Z","end":"2026-06-10T01:57:44.75161Z","steps":["trace[1086875518] 'agreement among raft nodes before linearized reading' (duration: 645.772681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:44.751665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:44.10567Z","time spent":"645.987206ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T01:57:44.75168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.794113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T01:57:44.751733Z","caller":"traceutil/trace.go:171","msg":"trace[1487031824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20370; }","duration":"597.879886ms","start":"2026-06-10T01:57:44.153839Z","end":"2026-06-10T01:57:44.751719Z","steps":["trace[1487031824] 'agreement among raft nodes before linearized reading' (duration: 597.707361ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:44.751754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.194403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-10T01:57:44.75179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.088588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T01:57:44.751789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:44.153828Z","time spent":"597.947487ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T01:57:44.751818Z","caller":"traceutil/trace.go:171","msg":"trace[1005351975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20370; }","duration":"535.172111ms","start":"2026-06-10T01:57:44.216636Z","end":"2026-06-10T01:57:44.751808Z","steps":["trace[1005351975] 'agreement among raft nodes before linearized reading' (duration: 535.13089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:44.751857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:44.216599Z","time spent":"535.251392ms","remote":"127.0.0.1:40800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T01:57:44.751821Z","caller":"traceutil/trace.go:171","msg":"trace[682127070] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:20370; }","duration":"269.306085ms","start":"2026-06-10T01:57:44.482496Z","end":"2026-06-10T01:57:44.751802Z","steps":["trace[682127070] 'agreement among raft nodes before linearized reading' (duration: 269.131331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:44.75194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.010034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-10T01:57:44.751992Z","caller":"traceutil/trace.go:171","msg":"trace[1396408602] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:20370; }","duration":"243.120906ms","start":"2026-06-10T01:57:44.508858Z","end":"2026-06-10T01:57:44.751979Z","steps":["trace[1396408602] 'agreement among raft nodes before linearized reading' (duration: 242.989273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:44.75186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.664077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-10T01:57:44.75212Z","caller":"traceutil/trace.go:171","msg":"trace[1454536258] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:20370; }","duration":"519.016934ms","start":"2026-06-10T01:57:44.233066Z","end":"2026-06-10T01:57:44.752083Z","steps":["trace[1454536258] 'agreement among raft nodes before linearized reading' (duration: 518.618585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:57:44.753141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:57:44.233036Z","time spent":"519.193118ms","remote":"127.0.0.1:40910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":380,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"info","ts":"2026-06-10T01:57:44.911169Z","caller":"traceutil/trace.go:171","msg":"trace[1876920909] transaction","detail":"{read_only:false; response_revision:20372; number_of_response:1; }","duration":"154.354235ms","start":"2026-06-10T01:57:44.756783Z","end":"2026-06-10T01:57:44.911137Z","steps":["trace[1876920909] 'process raft request' (duration: 154.221802ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:57:44.911238Z","caller":"traceutil/trace.go:171","msg":"trace[2086066181] transaction","detail":"{read_only:false; response_revision:20371; number_of_response:1; }","duration":"154.526639ms","start":"2026-06-10T01:57:44.75664Z","end":"2026-06-10T01:57:44.911167Z","steps":["trace[2086066181] 'process raft request' (duration: 153.245563ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:57:44.916506Z","caller":"traceutil/trace.go:171","msg":"trace[1180507526] transaction","detail":"{read_only:false; response_revision:20373; number_of_response:1; }","duration":"158.376345ms","start":"2026-06-10T01:57:44.758111Z","end":"2026-06-10T01:57:44.916487Z","steps":["trace[1180507526] 'process raft request' (duration: 158.209962ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:01:51.518776Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20097} {"level":"info","ts":"2026-06-10T02:01:51.633971Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20097,"took":"109.032742ms","hash":360702312,"current-db-size-bytes":57069568,"current-db-size":"57 MB","current-db-size-in-use-bytes":40759296,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-06-10T02:01:51.634141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":360702312,"revision":20097,"compact-revision":17716} {"level":"warn","ts":"2026-06-10T02:05:03.514781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.183547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:05:03.515039Z","caller":"traceutil/trace.go:171","msg":"trace[1267070165] transaction","detail":"{read_only:false; response_revision:24953; number_of_response:1; }","duration":"264.299797ms","start":"2026-06-10T02:05:03.25072Z","end":"2026-06-10T02:05:03.51502Z","steps":["trace[1267070165] 'process raft request' (duration: 264.198355ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:03.515056Z","caller":"traceutil/trace.go:171","msg":"trace[1618218811] transaction","detail":"{read_only:false; response_revision:24952; number_of_response:1; }","duration":"266.721796ms","start":"2026-06-10T02:05:03.248308Z","end":"2026-06-10T02:05:03.51503Z","steps":["trace[1618218811] 'process raft request' (duration: 124.182202ms)","trace[1618218811] 'compare' (duration: 141.82969ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:03.533024Z","caller":"traceutil/trace.go:171","msg":"trace[46861688] transaction","detail":"{read_only:false; response_revision:24954; number_of_response:1; }","duration":"127.421729ms","start":"2026-06-10T02:05:03.405572Z","end":"2026-06-10T02:05:03.532994Z","steps":["trace[46861688] 'process raft request' (duration: 127.236635ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:03.920822Z","caller":"traceutil/trace.go:171","msg":"trace[1157091900] transaction","detail":"{read_only:false; response_revision:24956; number_of_response:1; }","duration":"140.517684ms","start":"2026-06-10T02:05:03.780259Z","end":"2026-06-10T02:05:03.920777Z","steps":["trace[1157091900] 'process raft request' (duration: 140.222678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:04.073238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.408638ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:05:04.073415Z","caller":"traceutil/trace.go:171","msg":"trace[2102319603] transaction","detail":"{read_only:false; response_revision:24957; number_of_response:1; }","duration":"214.95704ms","start":"2026-06-10T02:05:03.858415Z","end":"2026-06-10T02:05:04.073372Z","steps":["trace[2102319603] 'process raft request' (duration: 83.303556ms)","trace[2102319603] 'compare' (duration: 131.254575ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:08.595776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.785254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:05:08.59605Z","caller":"traceutil/trace.go:171","msg":"trace[217174082] transaction","detail":"{read_only:false; response_revision:25004; number_of_response:1; }","duration":"367.653539ms","start":"2026-06-10T02:05:08.228328Z","end":"2026-06-10T02:05:08.595981Z","steps":["trace[217174082] 'process raft request' (duration: 114.525398ms)","trace[217174082] 'compare' (duration: 252.465748ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:08.596139Z","caller":"traceutil/trace.go:171","msg":"trace[1796841487] linearizableReadLoop","detail":"{readStateIndex:25823; appliedIndex:25822; }","duration":"362.204568ms","start":"2026-06-10T02:05:08.233681Z","end":"2026-06-10T02:05:08.595885Z","steps":["trace[1796841487] 'read index received' (duration: 9.371829ms)","trace[1796841487] 'applied index is now lower than readState.Index' (duration: 352.830999ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:08.596273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:08.228306Z","time spent":"367.853253ms","remote":"127.0.0.1:40972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":652,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:05:08.596398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.693529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:208"} {"level":"info","ts":"2026-06-10T02:05:08.596488Z","caller":"traceutil/trace.go:171","msg":"trace[301130990] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:25004; }","duration":"362.814781ms","start":"2026-06-10T02:05:08.233647Z","end":"2026-06-10T02:05:08.596461Z","steps":["trace[301130990] 'agreement among raft nodes before linearized reading' (duration: 362.583006ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:08.596542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:08.233635Z","time spent":"362.894492ms","remote":"127.0.0.1:41014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"info","ts":"2026-06-10T02:05:08.638338Z","caller":"traceutil/trace.go:171","msg":"trace[1635945911] transaction","detail":"{read_only:false; response_revision:25005; number_of_response:1; }","duration":"279.665189ms","start":"2026-06-10T02:05:08.358649Z","end":"2026-06-10T02:05:08.638314Z","steps":["trace[1635945911] 'process raft request' (duration: 279.534466ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:08.905604Z","caller":"traceutil/trace.go:171","msg":"trace[1153946206] transaction","detail":"{read_only:false; response_revision:25006; number_of_response:1; }","duration":"338.793055ms","start":"2026-06-10T02:05:08.566769Z","end":"2026-06-10T02:05:08.905562Z","steps":["trace[1153946206] 'process raft request' (duration: 338.513728ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:08.905778Z","caller":"traceutil/trace.go:171","msg":"trace[1964406516] transaction","detail":"{read_only:false; response_revision:25007; number_of_response:1; }","duration":"338.830947ms","start":"2026-06-10T02:05:08.566919Z","end":"2026-06-10T02:05:08.90575Z","steps":["trace[1964406516] 'process raft request' (duration: 338.586001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:08.905851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:08.566748Z","time spent":"338.968739ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:08.905792Z","caller":"traceutil/trace.go:171","msg":"trace[171224194] linearizableReadLoop","detail":"{readStateIndex:25826; appliedIndex:25823; }","duration":"309.529623ms","start":"2026-06-10T02:05:08.596198Z","end":"2026-06-10T02:05:08.905728Z","steps":["trace[171224194] 'read index received' (duration: 42.00577ms)","trace[171224194] 'applied index is now lower than readState.Index' (duration: 267.520203ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:08.906039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.941484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:08.906091Z","caller":"traceutil/trace.go:171","msg":"trace[1148855404] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:25007; }","duration":"657.054515ms","start":"2026-06-10T02:05:08.249023Z","end":"2026-06-10T02:05:08.906077Z","steps":["trace[1148855404] 'agreement among raft nodes before linearized reading' (duration: 656.920413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:08.906144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:08.249002Z","time spent":"657.131507ms","remote":"127.0.0.1:38372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":144,"response count":0,"response size":29,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true "} {"level":"warn","ts":"2026-06-10T02:05:08.906295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.680465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:208"} {"level":"warn","ts":"2026-06-10T02:05:08.906311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.296185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T02:05:08.906401Z","caller":"traceutil/trace.go:171","msg":"trace[552488799] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:25007; }","duration":"305.830668ms","start":"2026-06-10T02:05:08.600551Z","end":"2026-06-10T02:05:08.906382Z","steps":["trace[552488799] 'agreement among raft nodes before linearized reading' (duration: 305.559393ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:08.906445Z","caller":"traceutil/trace.go:171","msg":"trace[512660173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25007; }","duration":"121.482809ms","start":"2026-06-10T02:05:08.784923Z","end":"2026-06-10T02:05:08.906406Z","steps":["trace[512660173] 'agreement among raft nodes before linearized reading' (duration: 121.240074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:08.906454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:08.600536Z","time spent":"305.90915ms","remote":"127.0.0.1:41014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-06-10T02:05:08.906735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:08.566913Z","time spent":"338.932189ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:05:08.907023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.215669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T02:05:08.907088Z","caller":"traceutil/trace.go:171","msg":"trace[1648783566] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25007; }","duration":"487.27786ms","start":"2026-06-10T02:05:08.419792Z","end":"2026-06-10T02:05:08.90707Z","steps":["trace[1648783566] 'agreement among raft nodes before linearized reading' (duration: 486.029415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:08.907126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:08.419679Z","time spent":"487.436053ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T02:05:09.019636Z","caller":"traceutil/trace.go:171","msg":"trace[1253245963] transaction","detail":"{read_only:false; response_revision:25008; number_of_response:1; }","duration":"107.81248ms","start":"2026-06-10T02:05:08.911766Z","end":"2026-06-10T02:05:09.019579Z","steps":["trace[1253245963] 'process raft request' (duration: 106.004474ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:09.329952Z","caller":"traceutil/trace.go:171","msg":"trace[1133671108] transaction","detail":"{read_only:false; response_revision:25010; number_of_response:1; }","duration":"411.20008ms","start":"2026-06-10T02:05:08.918683Z","end":"2026-06-10T02:05:09.329883Z","steps":["trace[1133671108] 'process raft request' (duration: 410.946405ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:09.330041Z","caller":"traceutil/trace.go:171","msg":"trace[901677272] transaction","detail":"{read_only:false; response_revision:25011; number_of_response:1; }","duration":"102.659447ms","start":"2026-06-10T02:05:09.227359Z","end":"2026-06-10T02:05:09.330019Z","steps":["trace[901677272] 'process raft request' (duration: 102.443973ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:09.330034Z","caller":"traceutil/trace.go:171","msg":"trace[1610971226] linearizableReadLoop","detail":"{readStateIndex:25829; appliedIndex:25827; }","duration":"164.56619ms","start":"2026-06-10T02:05:09.165418Z","end":"2026-06-10T02:05:09.329985Z","steps":["trace[1610971226] 'read index received' (duration: 131.345068ms)","trace[1610971226] 'applied index is now lower than readState.Index' (duration: 33.218392ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:09.330048Z","caller":"traceutil/trace.go:171","msg":"trace[1969376784] transaction","detail":"{read_only:false; response_revision:25009; number_of_response:1; }","duration":"418.148741ms","start":"2026-06-10T02:05:08.911848Z","end":"2026-06-10T02:05:09.329997Z","steps":["trace[1969376784] 'process raft request' (duration: 384.893568ms)","trace[1969376784] 'compare' (duration: 32.494618ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:09.330192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:08.918662Z","time spent":"411.402965ms","remote":"127.0.0.1:41264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7836,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:05:09.330218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.573628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T02:05:09.330237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.814795ms","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-06-10T02:05:09.330267Z","caller":"traceutil/trace.go:171","msg":"trace[1558925753] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25011; }","duration":"116.671091ms","start":"2026-06-10T02:05:09.213582Z","end":"2026-06-10T02:05:09.330253Z","steps":["trace[1558925753] 'agreement among raft nodes before linearized reading' (duration: 116.579979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:09.330253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:08.911818Z","time spent":"418.327464ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:09.330283Z","caller":"traceutil/trace.go:171","msg":"trace[1607591960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25011; }","duration":"164.911197ms","start":"2026-06-10T02:05:09.165357Z","end":"2026-06-10T02:05:09.330268Z","steps":["trace[1607591960] 'agreement among raft nodes before linearized reading' (duration: 164.742864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:09.330285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.146347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T02:05:09.330318Z","caller":"traceutil/trace.go:171","msg":"trace[278666087] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25011; }","duration":"105.211298ms","start":"2026-06-10T02:05:09.225098Z","end":"2026-06-10T02:05:09.330309Z","steps":["trace[278666087] 'agreement among raft nodes before linearized reading' (duration: 105.062885ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:09.549802Z","caller":"traceutil/trace.go:171","msg":"trace[1466182514] linearizableReadLoop","detail":"{readStateIndex:25832; appliedIndex:25830; }","duration":"118.171681ms","start":"2026-06-10T02:05:09.431607Z","end":"2026-06-10T02:05:09.549779Z","steps":["trace[1466182514] 'read index received' (duration: 53.740637ms)","trace[1466182514] 'applied index is now lower than readState.Index' (duration: 64.430074ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:09.549971Z","caller":"traceutil/trace.go:171","msg":"trace[2056982469] transaction","detail":"{read_only:false; response_revision:25012; number_of_response:1; }","duration":"215.147434ms","start":"2026-06-10T02:05:09.334802Z","end":"2026-06-10T02:05:09.549949Z","steps":["trace[2056982469] 'process raft request' (duration: 150.458794ms)","trace[2056982469] 'compare' (duration: 64.145718ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:09.550028Z","caller":"traceutil/trace.go:171","msg":"trace[2136946715] transaction","detail":"{read_only:false; response_revision:25013; number_of_response:1; }","duration":"214.213625ms","start":"2026-06-10T02:05:09.335802Z","end":"2026-06-10T02:05:09.550016Z","steps":["trace[2136946715] 'process raft request' (duration: 213.861857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:09.550152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.53048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:09.550195Z","caller":"traceutil/trace.go:171","msg":"trace[1183743293] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:25013; }","duration":"118.638382ms","start":"2026-06-10T02:05:09.431544Z","end":"2026-06-10T02:05:09.550182Z","steps":["trace[1183743293] 'agreement among raft nodes before linearized reading' (duration: 118.55368ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:09.729119Z","caller":"traceutil/trace.go:171","msg":"trace[900862584] transaction","detail":"{read_only:false; response_revision:25014; number_of_response:1; }","duration":"178.647694ms","start":"2026-06-10T02:05:09.550443Z","end":"2026-06-10T02:05:09.729091Z","steps":["trace[900862584] 'process raft request' (duration: 178.483661ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:09.731285Z","caller":"traceutil/trace.go:171","msg":"trace[228426625] transaction","detail":"{read_only:false; response_revision:25016; number_of_response:1; }","duration":"176.972411ms","start":"2026-06-10T02:05:09.554286Z","end":"2026-06-10T02:05:09.731259Z","steps":["trace[228426625] 'process raft request' (duration: 176.763647ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:09.731285Z","caller":"traceutil/trace.go:171","msg":"trace[79510522] transaction","detail":"{read_only:false; response_revision:25015; number_of_response:1; }","duration":"177.234926ms","start":"2026-06-10T02:05:09.554012Z","end":"2026-06-10T02:05:09.731246Z","steps":["trace[79510522] 'process raft request' (duration: 176.93885ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:11.790598Z","caller":"traceutil/trace.go:171","msg":"trace[316014623] transaction","detail":"{read_only:false; response_revision:25030; number_of_response:1; }","duration":"233.525775ms","start":"2026-06-10T02:05:11.557049Z","end":"2026-06-10T02:05:11.790575Z","steps":["trace[316014623] 'process raft request' (duration: 233.364242ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:12.145189Z","caller":"traceutil/trace.go:171","msg":"trace[1129012176] linearizableReadLoop","detail":"{readStateIndex:25852; appliedIndex:25849; }","duration":"410.260372ms","start":"2026-06-10T02:05:11.734902Z","end":"2026-06-10T02:05:12.145162Z","steps":["trace[1129012176] 'read index received' (duration: 55.433493ms)","trace[1129012176] 'applied index is now lower than readState.Index' (duration: 354.825779ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:12.14531Z","caller":"traceutil/trace.go:171","msg":"trace[859773232] transaction","detail":"{read_only:false; response_revision:25031; number_of_response:1; }","duration":"587.485318ms","start":"2026-06-10T02:05:11.557811Z","end":"2026-06-10T02:05:12.145296Z","steps":["trace[859773232] 'process raft request' (duration: 587.10005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:12.145418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:11.557787Z","time spent":"587.551879ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:12.145546Z","caller":"traceutil/trace.go:171","msg":"trace[944958695] transaction","detail":"{read_only:false; response_revision:25032; number_of_response:1; }","duration":"410.886744ms","start":"2026-06-10T02:05:11.734631Z","end":"2026-06-10T02:05:12.145518Z","steps":["trace[944958695] 'process raft request' (duration: 410.468536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:12.145671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:11.734601Z","time spent":"410.999997ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:05:12.145803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.893175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T02:05:12.145846Z","caller":"traceutil/trace.go:171","msg":"trace[1098364962] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25032; }","duration":"410.964006ms","start":"2026-06-10T02:05:11.734868Z","end":"2026-06-10T02:05:12.145832Z","steps":["trace[1098364962] 'agreement among raft nodes before linearized reading' (duration: 410.810393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:12.145878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:11.734858Z","time spent":"411.013146ms","remote":"127.0.0.1:41074","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":"info","ts":"2026-06-10T02:05:12.174807Z","caller":"traceutil/trace.go:171","msg":"trace[830037152] transaction","detail":"{read_only:false; response_revision:25033; number_of_response:1; }","duration":"312.408192ms","start":"2026-06-10T02:05:11.862372Z","end":"2026-06-10T02:05:12.174781Z","steps":["trace[830037152] 'process raft request' (duration: 309.274068ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:12.175032Z","caller":"traceutil/trace.go:171","msg":"trace[1274053816] transaction","detail":"{read_only:false; response_revision:25034; number_of_response:1; }","duration":"216.917ms","start":"2026-06-10T02:05:11.958096Z","end":"2026-06-10T02:05:12.175013Z","steps":["trace[1274053816] 'process raft request' (duration: 216.134203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:12.17527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.664627ms","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":"info","ts":"2026-06-10T02:05:12.175354Z","caller":"traceutil/trace.go:171","msg":"trace[2060818469] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25036; }","duration":"439.779219ms","start":"2026-06-10T02:05:11.735553Z","end":"2026-06-10T02:05:12.175332Z","steps":["trace[2060818469] 'agreement among raft nodes before linearized reading' (duration: 439.590656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:12.17541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:11.735545Z","time spent":"439.852091ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-10T02:05:12.175481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:11.86234Z","time spent":"312.531434ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:28.241292Z","caller":"traceutil/trace.go:171","msg":"trace[788554899] transaction","detail":"{read_only:false; response_revision:25167; number_of_response:1; }","duration":"314.980614ms","start":"2026-06-10T02:05:27.926294Z","end":"2026-06-10T02:05:28.241274Z","steps":["trace[788554899] 'process raft request' (duration: 314.859342ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:28.241386Z","caller":"traceutil/trace.go:171","msg":"trace[602068326] linearizableReadLoop","detail":"{readStateIndex:25990; appliedIndex:25990; }","duration":"309.618116ms","start":"2026-06-10T02:05:27.931733Z","end":"2026-06-10T02:05:28.241351Z","steps":["trace[602068326] 'read index received' (duration: 309.587925ms)","trace[602068326] 'applied index is now lower than readState.Index' (duration: 26.571µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:28.241657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.914972ms","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-06-10T02:05:28.241694Z","caller":"traceutil/trace.go:171","msg":"trace[1114337584] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25167; }","duration":"309.990683ms","start":"2026-06-10T02:05:27.931695Z","end":"2026-06-10T02:05:28.241685Z","steps":["trace[1114337584] 'agreement among raft nodes before linearized reading' (duration: 309.732447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:28.241716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:27.931683Z","time spent":"310.027894ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":556,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-06-10T02:05:28.242201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:27.92627Z","time spent":"315.128697ms","remote":"127.0.0.1:59590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7897,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:28.35621Z","caller":"traceutil/trace.go:171","msg":"trace[460909993] transaction","detail":"{read_only:false; response_revision:25168; number_of_response:1; }","duration":"401.641137ms","start":"2026-06-10T02:05:27.954535Z","end":"2026-06-10T02:05:28.356177Z","steps":["trace[460909993] 'process raft request' (duration: 399.454933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:28.356357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:27.954503Z","time spent":"401.77482ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:28.356316Z","caller":"traceutil/trace.go:171","msg":"trace[1972908953] transaction","detail":"{read_only:false; response_revision:25169; number_of_response:1; }","duration":"150.524586ms","start":"2026-06-10T02:05:28.205752Z","end":"2026-06-10T02:05:28.356277Z","steps":["trace[1972908953] 'process raft request' (duration: 150.352313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:28.357009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.349588ms","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-06-10T02:05:28.357008Z","caller":"traceutil/trace.go:171","msg":"trace[1376332464] transaction","detail":"{read_only:false; response_revision:25170; number_of_response:1; }","duration":"125.947829ms","start":"2026-06-10T02:05:28.230756Z","end":"2026-06-10T02:05:28.356704Z","steps":["trace[1376332464] 'process raft request' (duration: 125.446359ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:28.357066Z","caller":"traceutil/trace.go:171","msg":"trace[938753960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25170; }","duration":"133.47145ms","start":"2026-06-10T02:05:28.223583Z","end":"2026-06-10T02:05:28.357054Z","steps":["trace[938753960] 'agreement among raft nodes before linearized reading' (duration: 133.208945ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:28.356763Z","caller":"traceutil/trace.go:171","msg":"trace[339749880] linearizableReadLoop","detail":"{readStateIndex:25993; appliedIndex:25990; }","duration":"115.224681ms","start":"2026-06-10T02:05:28.241447Z","end":"2026-06-10T02:05:28.356672Z","steps":["trace[339749880] 'read index received' (duration: 112.539386ms)","trace[339749880] 'applied index is now lower than readState.Index' (duration: 2.683725ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:28.400632Z","caller":"traceutil/trace.go:171","msg":"trace[802608079] transaction","detail":"{read_only:false; response_revision:25171; number_of_response:1; }","duration":"157.18524ms","start":"2026-06-10T02:05:28.243418Z","end":"2026-06-10T02:05:28.400604Z","steps":["trace[802608079] 'process raft request' (duration: 156.969566ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:28.40099Z","caller":"traceutil/trace.go:171","msg":"trace[432772110] transaction","detail":"{read_only:false; response_revision:25173; number_of_response:1; }","duration":"155.235671ms","start":"2026-06-10T02:05:28.245727Z","end":"2026-06-10T02:05:28.400963Z","steps":["trace[432772110] 'process raft request' (duration: 155.026217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:28.401154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18571"} {"level":"warn","ts":"2026-06-10T02:05:28.401154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.240701ms","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-06-10T02:05:28.401196Z","caller":"traceutil/trace.go:171","msg":"trace[832397400] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:25173; }","duration":"151.796061ms","start":"2026-06-10T02:05:28.249391Z","end":"2026-06-10T02:05:28.401187Z","steps":["trace[832397400] 'agreement among raft nodes before linearized reading' (duration: 151.600247ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:28.401232Z","caller":"traceutil/trace.go:171","msg":"trace[1249775898] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25173; }","duration":"152.378684ms","start":"2026-06-10T02:05:28.248833Z","end":"2026-06-10T02:05:28.401211Z","steps":["trace[1249775898] 'agreement among raft nodes before linearized reading' (duration: 152.096359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:28.401344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.096456ms","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-06-10T02:05:28.400943Z","caller":"traceutil/trace.go:171","msg":"trace[516288687] transaction","detail":"{read_only:false; response_revision:25172; number_of_response:1; }","duration":"155.231861ms","start":"2026-06-10T02:05:28.245673Z","end":"2026-06-10T02:05:28.400904Z","steps":["trace[516288687] 'process raft request' (duration: 154.879564ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:28.401426Z","caller":"traceutil/trace.go:171","msg":"trace[1229169810] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25174; }","duration":"148.224339ms","start":"2026-06-10T02:05:28.253183Z","end":"2026-06-10T02:05:28.401408Z","steps":["trace[1229169810] 'agreement among raft nodes before linearized reading' (duration: 147.795991ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:33.120496Z","caller":"traceutil/trace.go:171","msg":"trace[92704987] transaction","detail":"{read_only:false; response_revision:25207; number_of_response:1; }","duration":"125.037899ms","start":"2026-06-10T02:05:32.995433Z","end":"2026-06-10T02:05:33.120471Z","steps":["trace[92704987] 'process raft request' (duration: 124.847265ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:33.290744Z","caller":"traceutil/trace.go:171","msg":"trace[1198690058] linearizableReadLoop","detail":"{readStateIndex:26032; appliedIndex:26030; }","duration":"287.959717ms","start":"2026-06-10T02:05:33.00276Z","end":"2026-06-10T02:05:33.29072Z","steps":["trace[1198690058] 'read index received' (duration: 117.571929ms)","trace[1198690058] 'applied index is now lower than readState.Index' (duration: 170.386858ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:33.290858Z","caller":"traceutil/trace.go:171","msg":"trace[521615999] transaction","detail":"{read_only:false; response_revision:25208; number_of_response:1; }","duration":"289.133701ms","start":"2026-06-10T02:05:33.001679Z","end":"2026-06-10T02:05:33.290812Z","steps":["trace[521615999] 'process raft request' (duration: 288.861265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:33.290911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.1263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:33.290947Z","caller":"traceutil/trace.go:171","msg":"trace[979146960] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25208; }","duration":"288.203102ms","start":"2026-06-10T02:05:33.002733Z","end":"2026-06-10T02:05:33.290936Z","steps":["trace[979146960] 'agreement among raft nodes before linearized reading' (duration: 288.118391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:33.291115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.821552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-10T02:05:33.29121Z","caller":"traceutil/trace.go:171","msg":"trace[92555216] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25208; }","duration":"155.971505ms","start":"2026-06-10T02:05:33.135215Z","end":"2026-06-10T02:05:33.291187Z","steps":["trace[92555216] 'agreement among raft nodes before linearized reading' (duration: 155.69628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:34.221347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.609831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/subnets/\" range_end:\"/registry/openstack.k-orc.cloud/subnets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:34.221456Z","caller":"traceutil/trace.go:171","msg":"trace[1402278464] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/subnets/; range_end:/registry/openstack.k-orc.cloud/subnets0; response_count:0; response_revision:25211; }","duration":"124.734413ms","start":"2026-06-10T02:05:34.096695Z","end":"2026-06-10T02:05:34.22143Z","steps":["trace[1402278464] 'count revisions from in-memory index tree' (duration: 124.499459ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:34.496376Z","caller":"traceutil/trace.go:171","msg":"trace[650022762] transaction","detail":"{read_only:false; response_revision:25212; number_of_response:1; }","duration":"118.944657ms","start":"2026-06-10T02:05:34.377407Z","end":"2026-06-10T02:05:34.496352Z","steps":["trace[650022762] 'process raft request' (duration: 118.785454ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:34.613846Z","caller":"traceutil/trace.go:171","msg":"trace[804786196] transaction","detail":"{read_only:false; response_revision:25213; number_of_response:1; }","duration":"234.119358ms","start":"2026-06-10T02:05:34.379699Z","end":"2026-06-10T02:05:34.613819Z","steps":["trace[804786196] 'process raft request' (duration: 233.872342ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:34.613987Z","caller":"traceutil/trace.go:171","msg":"trace[1519134107] linearizableReadLoop","detail":"{readStateIndex:26039; appliedIndex:26035; }","duration":"184.526354ms","start":"2026-06-10T02:05:34.429441Z","end":"2026-06-10T02:05:34.613967Z","steps":["trace[1519134107] 'read index received' (duration: 66.784201ms)","trace[1519134107] 'applied index is now lower than readState.Index' (duration: 117.741243ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:34.614096Z","caller":"traceutil/trace.go:171","msg":"trace[1852217072] transaction","detail":"{read_only:false; response_revision:25215; number_of_response:1; }","duration":"190.997766ms","start":"2026-06-10T02:05:34.423076Z","end":"2026-06-10T02:05:34.614074Z","steps":["trace[1852217072] 'process raft request' (duration: 190.68415ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:34.614229Z","caller":"traceutil/trace.go:171","msg":"trace[296913246] transaction","detail":"{read_only:false; response_revision:25214; number_of_response:1; }","duration":"192.72739ms","start":"2026-06-10T02:05:34.421497Z","end":"2026-06-10T02:05:34.614224Z","steps":["trace[296913246] 'process raft request' (duration: 192.22766ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:34.614421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.193876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T02:05:34.614462Z","caller":"traceutil/trace.go:171","msg":"trace[441276402] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25215; }","duration":"181.308869ms","start":"2026-06-10T02:05:34.433144Z","end":"2026-06-10T02:05:34.614452Z","steps":["trace[441276402] 'agreement among raft nodes before linearized reading' (duration: 181.076914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:34.614506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.29059ms","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":"info","ts":"2026-06-10T02:05:34.614534Z","caller":"traceutil/trace.go:171","msg":"trace[1654140771] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25215; }","duration":"184.33881ms","start":"2026-06-10T02:05:34.430188Z","end":"2026-06-10T02:05:34.614527Z","steps":["trace[1654140771] 'agreement among raft nodes before linearized reading' (duration: 183.962423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:34.614655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.189767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-10T02:05:34.614687Z","caller":"traceutil/trace.go:171","msg":"trace[7279966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25215; }","duration":"185.287679ms","start":"2026-06-10T02:05:34.429391Z","end":"2026-06-10T02:05:34.614679Z","steps":["trace[7279966] 'agreement among raft nodes before linearized reading' (duration: 184.694477ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:35.087846Z","caller":"traceutil/trace.go:171","msg":"trace[1686560505] linearizableReadLoop","detail":"{readStateIndex:26045; appliedIndex:26044; }","duration":"133.083243ms","start":"2026-06-10T02:05:34.954738Z","end":"2026-06-10T02:05:35.087821Z","steps":["trace[1686560505] 'read index received' (duration: 132.862319ms)","trace[1686560505] 'applied index is now lower than readState.Index' (duration: 220.044µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:35.088047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.293848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:35.088087Z","caller":"traceutil/trace.go:171","msg":"trace[1648949764] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:25220; }","duration":"133.41176ms","start":"2026-06-10T02:05:34.954665Z","end":"2026-06-10T02:05:35.088077Z","steps":["trace[1648949764] 'agreement among raft nodes before linearized reading' (duration: 133.254517ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:35.088408Z","caller":"traceutil/trace.go:171","msg":"trace[1809131300] transaction","detail":"{read_only:false; response_revision:25220; number_of_response:1; }","duration":"353.686006ms","start":"2026-06-10T02:05:34.734709Z","end":"2026-06-10T02:05:35.088394Z","steps":["trace[1809131300] 'process raft request' (duration: 352.960702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:35.088549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:34.734695Z","time spent":"353.750107ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:35.32158Z","caller":"traceutil/trace.go:171","msg":"trace[326707982] linearizableReadLoop","detail":"{readStateIndex:26046; appliedIndex:26045; }","duration":"104.127817ms","start":"2026-06-10T02:05:35.217429Z","end":"2026-06-10T02:05:35.321557Z","steps":["trace[326707982] 'read index received' (duration: 93.506032ms)","trace[326707982] 'applied index is now lower than readState.Index' (duration: 10.621045ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:35.321684Z","caller":"traceutil/trace.go:171","msg":"trace[196634663] transaction","detail":"{read_only:false; response_revision:25221; number_of_response:1; }","duration":"196.191099ms","start":"2026-06-10T02:05:35.125479Z","end":"2026-06-10T02:05:35.32167Z","steps":["trace[196634663] 'process raft request' (duration: 185.445532ms)","trace[196634663] 'compare' (duration: 10.231407ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:35.32218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.701618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T02:05:35.322338Z","caller":"traceutil/trace.go:171","msg":"trace[1808672730] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:25221; }","duration":"104.939793ms","start":"2026-06-10T02:05:35.217373Z","end":"2026-06-10T02:05:35.322313Z","steps":["trace[1808672730] 'agreement among raft nodes before linearized reading' (duration: 104.621537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:35.332731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.692231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:35.332822Z","caller":"traceutil/trace.go:171","msg":"trace[137537717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25222; }","duration":"114.818304ms","start":"2026-06-10T02:05:35.217984Z","end":"2026-06-10T02:05:35.332802Z","steps":["trace[137537717] 'agreement among raft nodes before linearized reading' (duration: 114.62593ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:35.548996Z","caller":"traceutil/trace.go:171","msg":"trace[1127693325] transaction","detail":"{read_only:false; response_revision:25223; number_of_response:1; }","duration":"209.994219ms","start":"2026-06-10T02:05:35.338974Z","end":"2026-06-10T02:05:35.548968Z","steps":["trace[1127693325] 'process raft request' (duration: 152.078298ms)","trace[1127693325] 'compare' (duration: 57.500053ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:36.329532Z","caller":"traceutil/trace.go:171","msg":"trace[1713634918] linearizableReadLoop","detail":"{readStateIndex:26050; appliedIndex:26049; }","duration":"268.417311ms","start":"2026-06-10T02:05:36.061075Z","end":"2026-06-10T02:05:36.329493Z","steps":["trace[1713634918] 'read index received' (duration: 268.060734ms)","trace[1713634918] 'applied index is now lower than readState.Index' (duration: 355.017µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:36.329757Z","caller":"traceutil/trace.go:171","msg":"trace[368920207] transaction","detail":"{read_only:false; response_revision:25225; number_of_response:1; }","duration":"376.869535ms","start":"2026-06-10T02:05:35.952856Z","end":"2026-06-10T02:05:36.329726Z","steps":["trace[368920207] 'process raft request' (duration: 376.367195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:36.329867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.725327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:36.329979Z","caller":"traceutil/trace.go:171","msg":"trace[687872025] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:25225; }","duration":"268.877061ms","start":"2026-06-10T02:05:36.061036Z","end":"2026-06-10T02:05:36.329913Z","steps":["trace[687872025] 'agreement among raft nodes before linearized reading' (duration: 268.668567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:36.32996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.555048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:36.330068Z","caller":"traceutil/trace.go:171","msg":"trace[682066523] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:25225; }","duration":"115.706751ms","start":"2026-06-10T02:05:36.214329Z","end":"2026-06-10T02:05:36.330036Z","steps":["trace[682066523] 'agreement among raft nodes before linearized reading' (duration: 115.499197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:36.330106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:35.952828Z","time spent":"377.003278ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:36.545335Z","caller":"traceutil/trace.go:171","msg":"trace[2017317153] linearizableReadLoop","detail":"{readStateIndex:26051; appliedIndex:26050; }","duration":"108.671299ms","start":"2026-06-10T02:05:36.436634Z","end":"2026-06-10T02:05:36.545305Z","steps":["trace[2017317153] 'read index received' (duration: 94.286698ms)","trace[2017317153] 'applied index is now lower than readState.Index' (duration: 14.383361ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:36.545573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.933074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:186"} {"level":"info","ts":"2026-06-10T02:05:36.545624Z","caller":"traceutil/trace.go:171","msg":"trace[1338246560] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:25226; }","duration":"109.071527ms","start":"2026-06-10T02:05:36.43654Z","end":"2026-06-10T02:05:36.545612Z","steps":["trace[1338246560] 'agreement among raft nodes before linearized reading' (duration: 108.879863ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:36.545563Z","caller":"traceutil/trace.go:171","msg":"trace[823384723] transaction","detail":"{read_only:false; response_revision:25226; number_of_response:1; }","duration":"160.479507ms","start":"2026-06-10T02:05:36.38506Z","end":"2026-06-10T02:05:36.545539Z","steps":["trace[823384723] 'process raft request' (duration: 145.846131ms)","trace[823384723] 'compare' (duration: 14.207777ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:36.777573Z","caller":"traceutil/trace.go:171","msg":"trace[904843688] transaction","detail":"{read_only:false; response_revision:25228; number_of_response:1; }","duration":"157.253901ms","start":"2026-06-10T02:05:36.620282Z","end":"2026-06-10T02:05:36.777535Z","steps":["trace[904843688] 'process raft request' (duration: 151.386223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.152179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.871115ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:05:37.152438Z","caller":"traceutil/trace.go:171","msg":"trace[2127718277] linearizableReadLoop","detail":"{readStateIndex:26055; appliedIndex:26052; }","duration":"528.81076ms","start":"2026-06-10T02:05:36.623606Z","end":"2026-06-10T02:05:37.152417Z","steps":["trace[2127718277] 'read index received' (duration: 148.155148ms)","trace[2127718277] 'applied index is now lower than readState.Index' (duration: 380.654332ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:37.15248Z","caller":"traceutil/trace.go:171","msg":"trace[1900569149] transaction","detail":"{read_only:false; response_revision:25229; number_of_response:1; }","duration":"531.663129ms","start":"2026-06-10T02:05:36.620772Z","end":"2026-06-10T02:05:37.152435Z","steps":["trace[1900569149] 'process raft request' (duration: 369.442346ms)","trace[1900569149] 'compare' (duration: 161.163021ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:37.152523Z","caller":"traceutil/trace.go:171","msg":"trace[1481126364] transaction","detail":"{read_only:false; response_revision:25230; number_of_response:1; }","duration":"531.586676ms","start":"2026-06-10T02:05:36.620926Z","end":"2026-06-10T02:05:37.152513Z","steps":["trace[1481126364] 'process raft request' (duration: 531.359582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.15261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:36.620881Z","time spent":"531.681298ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:05:37.152622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.981204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T02:05:37.152663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:36.620743Z","time spent":"531.822151ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:37.152736Z","caller":"traceutil/trace.go:171","msg":"trace[139350981] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:25230; }","duration":"529.138027ms","start":"2026-06-10T02:05:36.623566Z","end":"2026-06-10T02:05:37.152704Z","steps":["trace[139350981] 'agreement among raft nodes before linearized reading' (duration: 528.971224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.152804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:36.623555Z","time spent":"529.227188ms","remote":"127.0.0.1:36654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-10T02:05:37.185703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.834076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:37.185774Z","caller":"traceutil/trace.go:171","msg":"trace[1369637403] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:25232; }","duration":"378.949109ms","start":"2026-06-10T02:05:36.806807Z","end":"2026-06-10T02:05:37.185757Z","steps":["trace[1369637403] 'agreement among raft nodes before linearized reading' (duration: 378.814726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.185803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:36.806792Z","time spent":"379.00446ms","remote":"127.0.0.1:59660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true "} {"level":"warn","ts":"2026-06-10T02:05:37.185897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.488618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-10T02:05:37.186039Z","caller":"traceutil/trace.go:171","msg":"trace[583148097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25232; }","duration":"543.817894ms","start":"2026-06-10T02:05:36.6422Z","end":"2026-06-10T02:05:37.186018Z","steps":["trace[583148097] 'agreement among raft nodes before linearized reading' (duration: 543.436866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.1861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.980457ms","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":"info","ts":"2026-06-10T02:05:37.18614Z","caller":"traceutil/trace.go:171","msg":"trace[1258086463] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25232; }","duration":"544.056838ms","start":"2026-06-10T02:05:36.642071Z","end":"2026-06-10T02:05:37.186127Z","steps":["trace[1258086463] 'agreement among raft nodes before linearized reading' (duration: 543.924986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.186172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:36.642052Z","time spent":"544.1126ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-10T02:05:37.186116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:36.642161Z","time spent":"543.941387ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T02:05:37.186218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.939467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T02:05:37.186371Z","caller":"traceutil/trace.go:171","msg":"trace[1411320479] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25232; }","duration":"544.14733ms","start":"2026-06-10T02:05:36.642178Z","end":"2026-06-10T02:05:37.186325Z","steps":["trace[1411320479] 'agreement among raft nodes before linearized reading' (duration: 543.916985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.186472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:36.642142Z","time spent":"544.295343ms","remote":"127.0.0.1:41074","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-06-10T02:05:37.446161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.494736ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:05:37.446277Z","caller":"traceutil/trace.go:171","msg":"trace[688840821] linearizableReadLoop","detail":"{readStateIndex:26058; appliedIndex:26057; }","duration":"255.373498ms","start":"2026-06-10T02:05:37.190885Z","end":"2026-06-10T02:05:37.446259Z","steps":["trace[688840821] 'read index received' (duration: 145.709648ms)","trace[688840821] 'applied index is now lower than readState.Index' (duration: 109.66237ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:37.446354Z","caller":"traceutil/trace.go:171","msg":"trace[58929245] transaction","detail":"{read_only:false; response_revision:25233; number_of_response:1; }","duration":"256.191515ms","start":"2026-06-10T02:05:37.19015Z","end":"2026-06-10T02:05:37.446342Z","steps":["trace[58929245] 'process raft request' (duration: 146.426313ms)","trace[58929245] 'compare' (duration: 109.292391ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:37.446498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.589892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:37.446607Z","caller":"traceutil/trace.go:171","msg":"trace[1416205548] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25233; }","duration":"255.749426ms","start":"2026-06-10T02:05:37.190834Z","end":"2026-06-10T02:05:37.446583Z","steps":["trace[1416205548] 'agreement among raft nodes before linearized reading' (duration: 255.578062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.839033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.229248ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:05:37.839286Z","caller":"traceutil/trace.go:171","msg":"trace[634762765] linearizableReadLoop","detail":"{readStateIndex:26062; appliedIndex:26058; }","duration":"392.963831ms","start":"2026-06-10T02:05:37.446303Z","end":"2026-06-10T02:05:37.839267Z","steps":["trace[634762765] 'read index received' (duration: 211.443388ms)","trace[634762765] 'applied index is now lower than readState.Index' (duration: 181.519293ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:37.839314Z","caller":"traceutil/trace.go:171","msg":"trace[2014784205] transaction","detail":"{read_only:false; response_revision:25235; number_of_response:1; }","duration":"647.844098ms","start":"2026-06-10T02:05:37.191429Z","end":"2026-06-10T02:05:37.839273Z","steps":["trace[2014784205] 'process raft request' (duration: 647.702945ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:37.839301Z","caller":"traceutil/trace.go:171","msg":"trace[1532793315] transaction","detail":"{read_only:false; response_revision:25234; number_of_response:1; }","duration":"648.084604ms","start":"2026-06-10T02:05:37.191163Z","end":"2026-06-10T02:05:37.839248Z","steps":["trace[1532793315] 'process raft request' (duration: 466.560121ms)","trace[1532793315] 'compare' (duration: 181.114644ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:37.839427Z","caller":"traceutil/trace.go:171","msg":"trace[2085724824] transaction","detail":"{read_only:false; response_revision:25236; number_of_response:1; }","duration":"509.553461ms","start":"2026-06-10T02:05:37.329861Z","end":"2026-06-10T02:05:37.839414Z","steps":["trace[2085724824] 'process raft request' (duration: 509.328176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.83951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:37.191409Z","time spent":"647.990532ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:05:37.839549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:37.191127Z","time spent":"648.286887ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:05:37.839567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.926756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:37.839622Z","caller":"traceutil/trace.go:171","msg":"trace[1857665575] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25237; }","duration":"625.028567ms","start":"2026-06-10T02:05:37.21458Z","end":"2026-06-10T02:05:37.839609Z","steps":["trace[1857665575] 'agreement among raft nodes before linearized reading' (duration: 624.918685ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.839652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:37.214564Z","time spent":"625.080928ms","remote":"127.0.0.1:40800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T02:05:37.83965Z","caller":"traceutil/trace.go:171","msg":"trace[1370193487] transaction","detail":"{read_only:false; response_revision:25237; number_of_response:1; }","duration":"499.178721ms","start":"2026-06-10T02:05:37.340436Z","end":"2026-06-10T02:05:37.839615Z","steps":["trace[1370193487] 'process raft request' (duration: 498.797903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.839591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:37.329832Z","time spent":"509.675093ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:05:37.839717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.103993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:37.839822Z","caller":"traceutil/trace.go:171","msg":"trace[413591557] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25237; }","duration":"387.333688ms","start":"2026-06-10T02:05:37.452473Z","end":"2026-06-10T02:05:37.839807Z","steps":["trace[413591557] 'agreement among raft nodes before linearized reading' (duration: 387.094763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.839841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.235111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-06-10T02:05:37.839844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:37.340402Z","time spent":"499.348524ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:05:37.839853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.325598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T02:05:37.839887Z","caller":"traceutil/trace.go:171","msg":"trace[639445946] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25237; }","duration":"287.318713ms","start":"2026-06-10T02:05:37.552554Z","end":"2026-06-10T02:05:37.839873Z","steps":["trace[639445946] 'agreement among raft nodes before linearized reading' (duration: 287.135839ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:37.83992Z","caller":"traceutil/trace.go:171","msg":"trace[1740906007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25237; }","duration":"262.41602ms","start":"2026-06-10T02:05:37.577488Z","end":"2026-06-10T02:05:37.839904Z","steps":["trace[1740906007] 'agreement among raft nodes before linearized reading' (duration: 262.187745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:37.839872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:37.452456Z","time spent":"387.404149ms","remote":"127.0.0.1:41088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"info","ts":"2026-06-10T02:05:38.187449Z","caller":"traceutil/trace.go:171","msg":"trace[502077604] linearizableReadLoop","detail":"{readStateIndex:26064; appliedIndex:26063; }","duration":"340.58119ms","start":"2026-06-10T02:05:37.846837Z","end":"2026-06-10T02:05:38.187419Z","steps":["trace[502077604] 'read index received' (duration: 55.107134ms)","trace[502077604] 'applied index is now lower than readState.Index' (duration: 285.472726ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:38.187531Z","caller":"traceutil/trace.go:171","msg":"trace[100554343] transaction","detail":"{read_only:false; response_revision:25239; number_of_response:1; }","duration":"341.148633ms","start":"2026-06-10T02:05:37.846328Z","end":"2026-06-10T02:05:38.187477Z","steps":["trace[100554343] 'process raft request' (duration: 244.583699ms)","trace[100554343] 'compare' (duration: 96.168106ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:38.188194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:37.846302Z","time spent":"341.681404ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:05:38.187676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.811256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:38.1884Z","caller":"traceutil/trace.go:171","msg":"trace[100541191] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25239; }","duration":"341.559151ms","start":"2026-06-10T02:05:37.846809Z","end":"2026-06-10T02:05:38.188368Z","steps":["trace[100541191] 'agreement among raft nodes before linearized reading' (duration: 340.774075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:38.187877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.658194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T02:05:38.18856Z","caller":"traceutil/trace.go:171","msg":"trace[69680271] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:25239; }","duration":"259.364738ms","start":"2026-06-10T02:05:37.929154Z","end":"2026-06-10T02:05:38.188519Z","steps":["trace[69680271] 'agreement among raft nodes before linearized reading' (duration: 258.617082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:38.188592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:37.846794Z","time spent":"341.698494ms","remote":"127.0.0.1:41088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"info","ts":"2026-06-10T02:05:38.890758Z","caller":"traceutil/trace.go:171","msg":"trace[982085175] linearizableReadLoop","detail":"{readStateIndex:26066; appliedIndex:26065; }","duration":"316.831781ms","start":"2026-06-10T02:05:38.573899Z","end":"2026-06-10T02:05:38.890731Z","steps":["trace[982085175] 'read index received' (duration: 316.620496ms)","trace[982085175] 'applied index is now lower than readState.Index' (duration: 210.235µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:38.890907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.988024ms","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:6"} {"level":"info","ts":"2026-06-10T02:05:38.890947Z","caller":"traceutil/trace.go:171","msg":"trace[1298288616] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:25241; }","duration":"317.085046ms","start":"2026-06-10T02:05:38.573845Z","end":"2026-06-10T02:05:38.89093Z","steps":["trace[1298288616] 'agreement among raft nodes before linearized reading' (duration: 316.979783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:38.890992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:38.573825Z","time spent":"317.157108ms","remote":"127.0.0.1:44688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-10T02:05:38.891224Z","caller":"traceutil/trace.go:171","msg":"trace[1288253965] transaction","detail":"{read_only:false; response_revision:25241; number_of_response:1; }","duration":"338.331066ms","start":"2026-06-10T02:05:38.552849Z","end":"2026-06-10T02:05:38.89118Z","steps":["trace[1288253965] 'process raft request' (duration: 337.674392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:38.891518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:38.55282Z","time spent":"338.497258ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:39.067082Z","caller":"traceutil/trace.go:171","msg":"trace[1706819564] transaction","detail":"{read_only:false; response_revision:25242; number_of_response:1; }","duration":"389.272827ms","start":"2026-06-10T02:05:38.677783Z","end":"2026-06-10T02:05:39.067056Z","steps":["trace[1706819564] 'process raft request' (duration: 359.981384ms)","trace[1706819564] 'compare' (duration: 29.14072ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:39.067245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:05:38.677761Z","time spent":"389.39546ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:05:39.067362Z","caller":"traceutil/trace.go:171","msg":"trace[787974212] transaction","detail":"{read_only:false; response_revision:25243; number_of_response:1; }","duration":"284.962915ms","start":"2026-06-10T02:05:38.78237Z","end":"2026-06-10T02:05:39.067333Z","steps":["trace[787974212] 'process raft request' (duration: 284.644309ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:39.28336Z","caller":"traceutil/trace.go:171","msg":"trace[971670126] transaction","detail":"{read_only:false; response_revision:25244; number_of_response:1; }","duration":"125.833586ms","start":"2026-06-10T02:05:39.157498Z","end":"2026-06-10T02:05:39.283332Z","steps":["trace[971670126] 'process raft request' (duration: 123.729345ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:39.283394Z","caller":"traceutil/trace.go:171","msg":"trace[1107136482] transaction","detail":"{read_only:false; response_revision:25245; number_of_response:1; }","duration":"125.493948ms","start":"2026-06-10T02:05:39.157868Z","end":"2026-06-10T02:05:39.283362Z","steps":["trace[1107136482] 'process raft request' (duration: 125.257943ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:39.283492Z","caller":"traceutil/trace.go:171","msg":"trace[58887362] transaction","detail":"{read_only:false; response_revision:25246; number_of_response:1; }","duration":"116.493507ms","start":"2026-06-10T02:05:39.166945Z","end":"2026-06-10T02:05:39.283439Z","steps":["trace[58887362] 'process raft request' (duration: 116.268862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:44.614897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.740338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3e9b7e39-bb2c-4887-9f1d-f6b6f5aa44ad\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-10T02:05:44.615018Z","caller":"traceutil/trace.go:171","msg":"trace[698852412] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3e9b7e39-bb2c-4887-9f1d-f6b6f5aa44ad; range_end:; response_count:1; response_revision:25349; }","duration":"100.929652ms","start":"2026-06-10T02:05:44.514061Z","end":"2026-06-10T02:05:44.614991Z","steps":["trace[698852412] 'range keys from in-memory index tree' (duration: 100.508834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:44.910118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.110612ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:44.910208Z","caller":"traceutil/trace.go:171","msg":"trace[1946801575] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25349; }","duration":"130.214594ms","start":"2026-06-10T02:05:44.779971Z","end":"2026-06-10T02:05:44.910186Z","steps":["trace[1946801575] 'range keys from in-memory index tree' (duration: 130.071841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:44.910699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.224294ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:05:44.911046Z","caller":"traceutil/trace.go:171","msg":"trace[1692036899] transaction","detail":"{read_only:false; response_revision:25350; number_of_response:1; }","duration":"258.878898ms","start":"2026-06-10T02:05:44.652103Z","end":"2026-06-10T02:05:44.910982Z","steps":["trace[1692036899] 'process raft request' (duration: 134.225256ms)","trace[1692036899] 'compare' (duration: 123.164452ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:44.911121Z","caller":"traceutil/trace.go:171","msg":"trace[1422090312] transaction","detail":"{read_only:false; response_revision:25351; number_of_response:1; }","duration":"220.533612ms","start":"2026-06-10T02:05:44.690556Z","end":"2026-06-10T02:05:44.91109Z","steps":["trace[1422090312] 'process raft request' (duration: 220.308667ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:45.203574Z","caller":"traceutil/trace.go:171","msg":"trace[1424200230] transaction","detail":"{read_only:false; response_revision:25353; number_of_response:1; }","duration":"118.729633ms","start":"2026-06-10T02:05:45.084815Z","end":"2026-06-10T02:05:45.203545Z","steps":["trace[1424200230] 'process raft request' (duration: 118.270184ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:45.354769Z","caller":"traceutil/trace.go:171","msg":"trace[1419962624] linearizableReadLoop","detail":"{readStateIndex:26182; appliedIndex:26181; }","duration":"138.285909ms","start":"2026-06-10T02:05:45.21646Z","end":"2026-06-10T02:05:45.354746Z","steps":["trace[1419962624] 'read index received' (duration: 138.182067ms)","trace[1419962624] 'applied index is now lower than readState.Index' (duration: 102.832µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:45.354888Z","caller":"traceutil/trace.go:171","msg":"trace[428240018] transaction","detail":"{read_only:false; response_revision:25354; number_of_response:1; }","duration":"139.37582ms","start":"2026-06-10T02:05:45.215501Z","end":"2026-06-10T02:05:45.354877Z","steps":["trace[428240018] 'process raft request' (duration: 139.062334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:45.355079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.563334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:45.355169Z","caller":"traceutil/trace.go:171","msg":"trace[505269428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25354; }","duration":"138.735158ms","start":"2026-06-10T02:05:45.216414Z","end":"2026-06-10T02:05:45.355149Z","steps":["trace[505269428] 'agreement among raft nodes before linearized reading' (duration: 138.480023ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:45.54456Z","caller":"traceutil/trace.go:171","msg":"trace[1925282192] linearizableReadLoop","detail":"{readStateIndex:26186; appliedIndex:26185; }","duration":"152.680309ms","start":"2026-06-10T02:05:45.391847Z","end":"2026-06-10T02:05:45.544527Z","steps":["trace[1925282192] 'read index received' (duration: 142.292659ms)","trace[1925282192] 'applied index is now lower than readState.Index' (duration: 10.38625ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:05:45.54491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.036127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:45.545001Z","caller":"traceutil/trace.go:171","msg":"trace[894921337] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:25358; }","duration":"153.161589ms","start":"2026-06-10T02:05:45.391819Z","end":"2026-06-10T02:05:45.544981Z","steps":["trace[894921337] 'agreement among raft nodes before linearized reading' (duration: 153.014526ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:45.544801Z","caller":"traceutil/trace.go:171","msg":"trace[165757340] transaction","detail":"{read_only:false; response_revision:25358; number_of_response:1; }","duration":"165.102641ms","start":"2026-06-10T02:05:45.379642Z","end":"2026-06-10T02:05:45.544745Z","steps":["trace[165757340] 'process raft request' (duration: 154.467816ms)","trace[165757340] 'compare' (duration: 10.022572ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:45.691082Z","caller":"traceutil/trace.go:171","msg":"trace[1000470661] transaction","detail":"{read_only:false; response_revision:25359; number_of_response:1; }","duration":"141.460733ms","start":"2026-06-10T02:05:45.549565Z","end":"2026-06-10T02:05:45.691025Z","steps":["trace[1000470661] 'process raft request' (duration: 126.551941ms)","trace[1000470661] 'compare' (duration: 14.740649ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:47.546177Z","caller":"traceutil/trace.go:171","msg":"trace[479285946] transaction","detail":"{read_only:false; response_revision:25373; number_of_response:1; }","duration":"164.06804ms","start":"2026-06-10T02:05:47.382078Z","end":"2026-06-10T02:05:47.546146Z","steps":["trace[479285946] 'process raft request' (duration: 163.986419ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:47.546278Z","caller":"traceutil/trace.go:171","msg":"trace[1139541197] transaction","detail":"{read_only:false; response_revision:25372; number_of_response:1; }","duration":"164.465958ms","start":"2026-06-10T02:05:47.381756Z","end":"2026-06-10T02:05:47.546222Z","steps":["trace[1139541197] 'process raft request' (duration: 164.05681ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:51.183874Z","caller":"traceutil/trace.go:171","msg":"trace[1576276578] transaction","detail":"{read_only:false; response_revision:25414; number_of_response:1; }","duration":"241.838083ms","start":"2026-06-10T02:05:50.941788Z","end":"2026-06-10T02:05:51.183626Z","steps":["trace[1576276578] 'process raft request' (duration: 241.559467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:05:51.38059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.501149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:05:51.380675Z","caller":"traceutil/trace.go:171","msg":"trace[1883674574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25414; }","duration":"165.628081ms","start":"2026-06-10T02:05:51.215025Z","end":"2026-06-10T02:05:51.380653Z","steps":["trace[1883674574] 'range keys from in-memory index tree' (duration: 165.396437ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:51.381481Z","caller":"traceutil/trace.go:171","msg":"trace[1434257704] transaction","detail":"{read_only:false; response_revision:25415; number_of_response:1; }","duration":"158.277314ms","start":"2026-06-10T02:05:51.222702Z","end":"2026-06-10T02:05:51.380979Z","steps":["trace[1434257704] 'process raft request' (duration: 105.658849ms)","trace[1434257704] 'compare' (duration: 52.073374ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:05:51.533617Z","caller":"traceutil/trace.go:171","msg":"trace[1176053084] transaction","detail":"{read_only:false; response_revision:25416; number_of_response:1; }","duration":"142.627446ms","start":"2026-06-10T02:05:51.39096Z","end":"2026-06-10T02:05:51.533588Z","steps":["trace[1176053084] 'process raft request' (duration: 142.446212ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:05:51.534089Z","caller":"traceutil/trace.go:171","msg":"trace[2010268548] transaction","detail":"{read_only:false; response_revision:25417; number_of_response:1; }","duration":"118.55301ms","start":"2026-06-10T02:05:51.415517Z","end":"2026-06-10T02:05:51.53407Z","steps":["trace[2010268548] 'process raft request' (duration: 118.442547ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:03.398691Z","caller":"traceutil/trace.go:171","msg":"trace[1113957106] transaction","detail":"{read_only:false; response_revision:25516; number_of_response:1; }","duration":"170.019331ms","start":"2026-06-10T02:06:03.228639Z","end":"2026-06-10T02:06:03.398658Z","steps":["trace[1113957106] 'process raft request' (duration: 169.530321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:03.570219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.503944ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:06:03.570301Z","caller":"traceutil/trace.go:171","msg":"trace[189635277] transaction","detail":"{read_only:false; response_revision:25517; number_of_response:1; }","duration":"155.451666ms","start":"2026-06-10T02:06:03.414834Z","end":"2026-06-10T02:06:03.570286Z","steps":["trace[189635277] 'process raft request' (duration: 53.816779ms)","trace[189635277] 'compare' (duration: 101.28645ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:03.849281Z","caller":"traceutil/trace.go:171","msg":"trace[325613366] transaction","detail":"{read_only:false; response_revision:25518; number_of_response:1; }","duration":"278.272631ms","start":"2026-06-10T02:06:03.57099Z","end":"2026-06-10T02:06:03.849263Z","steps":["trace[325613366] 'process raft request' (duration: 278.162869ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:03.998015Z","caller":"traceutil/trace.go:171","msg":"trace[1061375179] transaction","detail":"{read_only:false; response_revision:25519; number_of_response:1; }","duration":"401.884812ms","start":"2026-06-10T02:06:03.596109Z","end":"2026-06-10T02:06:03.997994Z","steps":["trace[1061375179] 'process raft request' (duration: 320.788001ms)","trace[1061375179] 'compare' (duration: 80.930948ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:06:03.998199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:03.596091Z","time spent":"402.039076ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:06:03.998252Z","caller":"traceutil/trace.go:171","msg":"trace[244239119] transaction","detail":"{read_only:false; response_revision:25520; number_of_response:1; }","duration":"398.35913ms","start":"2026-06-10T02:06:03.599836Z","end":"2026-06-10T02:06:03.998195Z","steps":["trace[244239119] 'process raft request' (duration: 398.129216ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:03.998378Z","caller":"traceutil/trace.go:171","msg":"trace[342539818] linearizableReadLoop","detail":"{readStateIndex:26351; appliedIndex:26349; }","duration":"387.01312ms","start":"2026-06-10T02:06:03.61134Z","end":"2026-06-10T02:06:03.998353Z","steps":["trace[342539818] 'read index received' (duration: 238.045756ms)","trace[342539818] 'applied index is now lower than readState.Index' (duration: 148.966234ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:06:03.998487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:03.599829Z","time spent":"398.531224ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:06:03.998609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.233526ms","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:8"} {"level":"info","ts":"2026-06-10T02:06:03.998692Z","caller":"traceutil/trace.go:171","msg":"trace[572459083] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25521; }","duration":"387.363578ms","start":"2026-06-10T02:06:03.611311Z","end":"2026-06-10T02:06:03.998675Z","steps":["trace[572459083] 'agreement among raft nodes before linearized reading' (duration: 387.202215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:03.998746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:03.611302Z","time spent":"387.433979ms","remote":"127.0.0.1:40114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-10T02:06:04.01023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.618677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-10T02:06:04.010384Z","caller":"traceutil/trace.go:171","msg":"trace[524792294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25522; }","duration":"236.802021ms","start":"2026-06-10T02:06:03.773562Z","end":"2026-06-10T02:06:04.010364Z","steps":["trace[524792294] 'agreement among raft nodes before linearized reading' (duration: 236.595737ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:04.222579Z","caller":"traceutil/trace.go:171","msg":"trace[1900354843] transaction","detail":"{read_only:false; response_revision:25524; number_of_response:1; }","duration":"206.281235ms","start":"2026-06-10T02:06:04.016268Z","end":"2026-06-10T02:06:04.222549Z","steps":["trace[1900354843] 'process raft request' (duration: 206.178343ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:04.222642Z","caller":"traceutil/trace.go:171","msg":"trace[1178478345] linearizableReadLoop","detail":"{readStateIndex:26356; appliedIndex:26353; }","duration":"206.199693ms","start":"2026-06-10T02:06:04.01642Z","end":"2026-06-10T02:06:04.22262Z","steps":["trace[1178478345] 'read index received' (duration: 137.655156ms)","trace[1178478345] 'applied index is now lower than readState.Index' (duration: 68.543657ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:04.222655Z","caller":"traceutil/trace.go:171","msg":"trace[1101340657] transaction","detail":"{read_only:false; response_revision:25523; number_of_response:1; }","duration":"207.085271ms","start":"2026-06-10T02:06:04.015494Z","end":"2026-06-10T02:06:04.222579Z","steps":["trace[1101340657] 'process raft request' (duration: 138.445101ms)","trace[1101340657] 'compare' (duration: 67.925015ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:04.22268Z","caller":"traceutil/trace.go:171","msg":"trace[486617768] transaction","detail":"{read_only:false; response_revision:25525; number_of_response:1; }","duration":"206.318185ms","start":"2026-06-10T02:06:04.016332Z","end":"2026-06-10T02:06:04.222651Z","steps":["trace[486617768] 'process raft request' (duration: 206.181412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:04.222858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.601958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-10T02:06:04.222883Z","caller":"traceutil/trace.go:171","msg":"trace[1289481931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25525; }","duration":"196.675069ms","start":"2026-06-10T02:06:04.0262Z","end":"2026-06-10T02:06:04.222875Z","steps":["trace[1289481931] 'agreement among raft nodes before linearized reading' (duration: 196.526456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:04.222886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.441418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18571"} {"level":"info","ts":"2026-06-10T02:06:04.222948Z","caller":"traceutil/trace.go:171","msg":"trace[1077220000] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25525; }","duration":"206.585501ms","start":"2026-06-10T02:06:04.016348Z","end":"2026-06-10T02:06:04.222934Z","steps":["trace[1077220000] 'agreement among raft nodes before linearized reading' (duration: 206.352086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:04.449692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.610609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T02:06:04.449781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.529309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T02:06:04.449809Z","caller":"traceutil/trace.go:171","msg":"trace[610769317] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:25526; }","duration":"111.771562ms","start":"2026-06-10T02:06:04.338011Z","end":"2026-06-10T02:06:04.449783Z","steps":["trace[610769317] 'count revisions from in-memory index tree' (duration: 111.519596ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:04.449861Z","caller":"traceutil/trace.go:171","msg":"trace[1339660543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25526; }","duration":"119.695972ms","start":"2026-06-10T02:06:04.330147Z","end":"2026-06-10T02:06:04.449843Z","steps":["trace[1339660543] 'range keys from in-memory index tree' (duration: 119.300524ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:04.591999Z","caller":"traceutil/trace.go:171","msg":"trace[160064187] linearizableReadLoop","detail":"{readStateIndex:26358; appliedIndex:26357; }","duration":"138.3327ms","start":"2026-06-10T02:06:04.453639Z","end":"2026-06-10T02:06:04.591972Z","steps":["trace[160064187] 'read index received' (duration: 138.085765ms)","trace[160064187] 'applied index is now lower than readState.Index' (duration: 245.735µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:04.59215Z","caller":"traceutil/trace.go:171","msg":"trace[991117204] transaction","detail":"{read_only:false; response_revision:25527; number_of_response:1; }","duration":"138.519293ms","start":"2026-06-10T02:06:04.453602Z","end":"2026-06-10T02:06:04.592122Z","steps":["trace[991117204] 'process raft request' (duration: 138.192497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:04.592223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.552154ms","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:8"} {"level":"info","ts":"2026-06-10T02:06:04.592264Z","caller":"traceutil/trace.go:171","msg":"trace[1453778746] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25527; }","duration":"138.658427ms","start":"2026-06-10T02:06:04.453592Z","end":"2026-06-10T02:06:04.592251Z","steps":["trace[1453778746] 'agreement among raft nodes before linearized reading' (duration: 138.527334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:04.592615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.943392ms","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-06-10T02:06:04.59269Z","caller":"traceutil/trace.go:171","msg":"trace[387943413] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25527; }","duration":"101.056555ms","start":"2026-06-10T02:06:04.491615Z","end":"2026-06-10T02:06:04.592672Z","steps":["trace[387943413] 'agreement among raft nodes before linearized reading' (duration: 100.830431ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:04.730801Z","caller":"traceutil/trace.go:171","msg":"trace[2070390596] transaction","detail":"{read_only:false; response_revision:25528; number_of_response:1; }","duration":"134.483291ms","start":"2026-06-10T02:06:04.596293Z","end":"2026-06-10T02:06:04.730776Z","steps":["trace[2070390596] 'process raft request' (duration: 134.317278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:04.951007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.186888ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:06:04.951124Z","caller":"traceutil/trace.go:171","msg":"trace[1308421105] transaction","detail":"{read_only:false; response_revision:25529; number_of_response:1; }","duration":"219.497301ms","start":"2026-06-10T02:06:04.731607Z","end":"2026-06-10T02:06:04.951105Z","steps":["trace[1308421105] 'process raft request' (duration: 119.12561ms)","trace[1308421105] 'compare' (duration: 100.065605ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:06.107534Z","caller":"traceutil/trace.go:171","msg":"trace[313201982] transaction","detail":"{read_only:false; response_revision:25534; number_of_response:1; }","duration":"104.185178ms","start":"2026-06-10T02:06:06.003314Z","end":"2026-06-10T02:06:06.1075Z","steps":["trace[313201982] 'process raft request' (duration: 103.749899ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:06.107662Z","caller":"traceutil/trace.go:171","msg":"trace[146022202] transaction","detail":"{read_only:false; response_revision:25535; number_of_response:1; }","duration":"104.161088ms","start":"2026-06-10T02:06:06.00347Z","end":"2026-06-10T02:06:06.107631Z","steps":["trace[146022202] 'process raft request' (duration: 103.736489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:16.314807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.163151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:06:16.314911Z","caller":"traceutil/trace.go:171","msg":"trace[1914915871] transaction","detail":"{read_only:false; response_revision:25618; number_of_response:1; }","duration":"207.074681ms","start":"2026-06-10T02:06:16.107819Z","end":"2026-06-10T02:06:16.314894Z","steps":["trace[1914915871] 'process raft request' (duration: 88.727055ms)","trace[1914915871] 'compare' (duration: 118.061019ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:06:16.627319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.755045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:06:16.627579Z","caller":"traceutil/trace.go:171","msg":"trace[1690668789] linearizableReadLoop","detail":"{readStateIndex:26455; appliedIndex:26452; }","duration":"380.093722ms","start":"2026-06-10T02:06:16.247468Z","end":"2026-06-10T02:06:16.627562Z","steps":["trace[1690668789] 'read index received' (duration: 166.932548ms)","trace[1690668789] 'applied index is now lower than readState.Index' (duration: 213.160274ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:16.627593Z","caller":"traceutil/trace.go:171","msg":"trace[1990670935] transaction","detail":"{read_only:false; response_revision:25619; number_of_response:1; }","duration":"472.039281ms","start":"2026-06-10T02:06:16.155515Z","end":"2026-06-10T02:06:16.627554Z","steps":["trace[1990670935] 'process raft request' (duration: 258.96762ms)","trace[1990670935] 'compare' (duration: 212.638193ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:16.627625Z","caller":"traceutil/trace.go:171","msg":"trace[1699624285] transaction","detail":"{read_only:false; response_revision:25620; number_of_response:1; }","duration":"470.110173ms","start":"2026-06-10T02:06:16.157468Z","end":"2026-06-10T02:06:16.627578Z","steps":["trace[1699624285] 'process raft request' (duration: 469.97676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:16.627689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.209084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:06:16.627771Z","caller":"traceutil/trace.go:171","msg":"trace[184569793] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:25621; }","duration":"380.333046ms","start":"2026-06-10T02:06:16.247416Z","end":"2026-06-10T02:06:16.627749Z","steps":["trace[184569793] 'agreement among raft nodes before linearized reading' (duration: 380.198774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:16.627769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:16.155489Z","time spent":"472.190894ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:06:16.627631Z","caller":"traceutil/trace.go:171","msg":"trace[1012256343] transaction","detail":"{read_only:false; response_revision:25621; number_of_response:1; }","duration":"468.140163ms","start":"2026-06-10T02:06:16.159449Z","end":"2026-06-10T02:06:16.627589Z","steps":["trace[1012256343] 'process raft request' (duration: 468.069612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:16.627826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:16.247395Z","time spent":"380.419278ms","remote":"127.0.0.1:46510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-10T02:06:16.627783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:16.157437Z","time spent":"470.280167ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:06:16.627859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:16.15944Z","time spent":"468.389268ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:06:16.643907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.828744ms","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-06-10T02:06:16.64399Z","caller":"traceutil/trace.go:171","msg":"trace[926767943] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25622; }","duration":"371.962087ms","start":"2026-06-10T02:06:16.272009Z","end":"2026-06-10T02:06:16.643971Z","steps":["trace[926767943] 'agreement among raft nodes before linearized reading' (duration: 371.754323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:16.644029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:16.271988Z","time spent":"372.032949ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T02:06:16.644112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.684217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T02:06:16.644158Z","caller":"traceutil/trace.go:171","msg":"trace[492040470] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25622; }","duration":"313.771139ms","start":"2026-06-10T02:06:16.330373Z","end":"2026-06-10T02:06:16.644145Z","steps":["trace[492040470] 'agreement among raft nodes before linearized reading' (duration: 313.682267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:16.644194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:16.33035Z","time spent":"313.83606ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T02:06:16.644298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.891735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-06-10T02:06:16.644012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.455696ms","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-06-10T02:06:16.644375Z","caller":"traceutil/trace.go:171","msg":"trace[896210664] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25622; }","duration":"368.880545ms","start":"2026-06-10T02:06:16.275479Z","end":"2026-06-10T02:06:16.64436Z","steps":["trace[896210664] 'agreement among raft nodes before linearized reading' (duration: 368.379445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:16.644412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:16.275447Z","time spent":"368.956066ms","remote":"127.0.0.1:41074","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":"info","ts":"2026-06-10T02:06:16.644336Z","caller":"traceutil/trace.go:171","msg":"trace[1598414160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25622; }","duration":"368.952456ms","start":"2026-06-10T02:06:16.275375Z","end":"2026-06-10T02:06:16.644327Z","steps":["trace[1598414160] 'agreement among raft nodes before linearized reading' (duration: 368.851044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:16.644485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:16.275363Z","time spent":"369.100519ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T02:06:16.819655Z","caller":"traceutil/trace.go:171","msg":"trace[1500663301] transaction","detail":"{read_only:false; response_revision:25625; number_of_response:1; }","duration":"170.107112ms","start":"2026-06-10T02:06:16.649508Z","end":"2026-06-10T02:06:16.819615Z","steps":["trace[1500663301] 'process raft request' (duration: 169.880998ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:16.819687Z","caller":"traceutil/trace.go:171","msg":"trace[778503993] transaction","detail":"{read_only:false; response_revision:25624; number_of_response:1; }","duration":"170.551191ms","start":"2026-06-10T02:06:16.649105Z","end":"2026-06-10T02:06:16.819656Z","steps":["trace[778503993] 'process raft request' (duration: 170.130263ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:16.819751Z","caller":"traceutil/trace.go:171","msg":"trace[914206308] transaction","detail":"{read_only:false; response_revision:25626; number_of_response:1; }","duration":"167.166333ms","start":"2026-06-10T02:06:16.652559Z","end":"2026-06-10T02:06:16.819725Z","steps":["trace[914206308] 'process raft request' (duration: 166.873258ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:16.819803Z","caller":"traceutil/trace.go:171","msg":"trace[1532712140] transaction","detail":"{read_only:false; response_revision:25627; number_of_response:1; }","duration":"167.147773ms","start":"2026-06-10T02:06:16.652615Z","end":"2026-06-10T02:06:16.819763Z","steps":["trace[1532712140] 'process raft request' (duration: 166.853897ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:30.799325Z","caller":"traceutil/trace.go:171","msg":"trace[1329965307] transaction","detail":"{read_only:false; response_revision:25723; number_of_response:1; }","duration":"124.950978ms","start":"2026-06-10T02:06:30.674344Z","end":"2026-06-10T02:06:30.799295Z","steps":["trace[1329965307] 'process raft request' (duration: 124.745784ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:30.851551Z","caller":"traceutil/trace.go:171","msg":"trace[632724489] transaction","detail":"{read_only:false; response_revision:25724; number_of_response:1; }","duration":"165.741585ms","start":"2026-06-10T02:06:30.685788Z","end":"2026-06-10T02:06:30.85153Z","steps":["trace[632724489] 'process raft request' (duration: 165.539071ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:30.851778Z","caller":"traceutil/trace.go:171","msg":"trace[1943633364] transaction","detail":"{read_only:false; response_revision:25725; number_of_response:1; }","duration":"163.965368ms","start":"2026-06-10T02:06:30.68779Z","end":"2026-06-10T02:06:30.851755Z","steps":["trace[1943633364] 'process raft request' (duration: 163.680442ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:41.007928Z","caller":"traceutil/trace.go:171","msg":"trace[1093338757] transaction","detail":"{read_only:false; response_revision:25805; number_of_response:1; }","duration":"174.96282ms","start":"2026-06-10T02:06:40.83293Z","end":"2026-06-10T02:06:41.007893Z","steps":["trace[1093338757] 'process raft request' (duration: 174.779956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:41.008015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.521665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:06:41.008162Z","caller":"traceutil/trace.go:171","msg":"trace[1897211987] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:25805; }","duration":"150.659499ms","start":"2026-06-10T02:06:40.857403Z","end":"2026-06-10T02:06:41.008063Z","steps":["trace[1897211987] 'agreement among raft nodes before linearized reading' (duration: 150.538057ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:41.007913Z","caller":"traceutil/trace.go:171","msg":"trace[1700529830] linearizableReadLoop","detail":"{readStateIndex:26644; appliedIndex:26643; }","duration":"150.387253ms","start":"2026-06-10T02:06:40.857469Z","end":"2026-06-10T02:06:41.007857Z","steps":["trace[1700529830] 'read index received' (duration: 150.291391ms)","trace[1700529830] 'applied index is now lower than readState.Index' (duration: 94.812µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:41.033834Z","caller":"traceutil/trace.go:171","msg":"trace[2034763108] transaction","detail":"{read_only:false; response_revision:25807; number_of_response:1; }","duration":"139.770918ms","start":"2026-06-10T02:06:40.894026Z","end":"2026-06-10T02:06:41.033797Z","steps":["trace[2034763108] 'process raft request' (duration: 139.670076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:41.033943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.815727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T02:06:41.03401Z","caller":"traceutil/trace.go:171","msg":"trace[443441123] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25807; }","duration":"135.962411ms","start":"2026-06-10T02:06:40.89803Z","end":"2026-06-10T02:06:41.033992Z","steps":["trace[443441123] 'agreement among raft nodes before linearized reading' (duration: 135.723526ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:41.03409Z","caller":"traceutil/trace.go:171","msg":"trace[673436390] transaction","detail":"{read_only:false; response_revision:25806; number_of_response:1; }","duration":"141.133585ms","start":"2026-06-10T02:06:40.892641Z","end":"2026-06-10T02:06:41.033774Z","steps":["trace[673436390] 'process raft request' (duration: 140.894411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:41.464747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.320865ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:06:41.464911Z","caller":"traceutil/trace.go:171","msg":"trace[1200898379] transaction","detail":"{read_only:false; response_revision:25812; number_of_response:1; }","duration":"384.352457ms","start":"2026-06-10T02:06:41.080546Z","end":"2026-06-10T02:06:41.464899Z","steps":["trace[1200898379] 'process raft request' (duration: 384.305246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:41.464948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:41.080523Z","time spent":"384.408157ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:06:41.465087Z","caller":"traceutil/trace.go:171","msg":"trace[828421831] transaction","detail":"{read_only:false; response_revision:25810; number_of_response:1; }","duration":"385.742894ms","start":"2026-06-10T02:06:41.079339Z","end":"2026-06-10T02:06:41.465082Z","steps":["trace[828421831] 'process raft request' (duration: 261.028181ms)","trace[828421831] 'compare' (duration: 123.945738ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:06:41.465118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:41.079305Z","time spent":"385.795206ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:06:41.465149Z","caller":"traceutil/trace.go:171","msg":"trace[1260466324] transaction","detail":"{read_only:false; response_revision:25811; number_of_response:1; }","duration":"384.653093ms","start":"2026-06-10T02:06:41.08046Z","end":"2026-06-10T02:06:41.465113Z","steps":["trace[1260466324] 'process raft request' (duration: 384.355857ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:41.465351Z","caller":"traceutil/trace.go:171","msg":"trace[2013871579] transaction","detail":"{read_only:false; response_revision:25813; number_of_response:1; }","duration":"384.061651ms","start":"2026-06-10T02:06:41.081251Z","end":"2026-06-10T02:06:41.465313Z","steps":["trace[2013871579] 'process raft request' (duration: 383.622512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:41.465529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:41.080446Z","time spent":"384.968519ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:06:41.465531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:06:41.08124Z","time spent":"384.185123ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T02:06:41.709938Z","caller":"traceutil/trace.go:171","msg":"trace[2019855744] transaction","detail":"{read_only:false; response_revision:25815; number_of_response:1; }","duration":"103.821581ms","start":"2026-06-10T02:06:41.606073Z","end":"2026-06-10T02:06:41.709895Z","steps":["trace[2019855744] 'process raft request' (duration: 99.040884ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:41.936059Z","caller":"traceutil/trace.go:171","msg":"trace[394130164] linearizableReadLoop","detail":"{readStateIndex:26656; appliedIndex:26655; }","duration":"155.037837ms","start":"2026-06-10T02:06:41.780987Z","end":"2026-06-10T02:06:41.936025Z","steps":["trace[394130164] 'read index received' (duration: 75.251903ms)","trace[394130164] 'applied index is now lower than readState.Index' (duration: 79.784404ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:06:41.936286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.270633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:06:41.936337Z","caller":"traceutil/trace.go:171","msg":"trace[1669705826] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:25817; }","duration":"155.389425ms","start":"2026-06-10T02:06:41.780932Z","end":"2026-06-10T02:06:41.936321Z","steps":["trace[1669705826] 'agreement among raft nodes before linearized reading' (duration: 155.264882ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:41.936426Z","caller":"traceutil/trace.go:171","msg":"trace[1347991748] transaction","detail":"{read_only:false; response_revision:25817; number_of_response:1; }","duration":"189.679328ms","start":"2026-06-10T02:06:41.746705Z","end":"2026-06-10T02:06:41.936384Z","steps":["trace[1347991748] 'process raft request' (duration: 109.487615ms)","trace[1347991748] 'compare' (duration: 79.460457ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:06:42.243202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.470528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:06:42.243285Z","caller":"traceutil/trace.go:171","msg":"trace[1633250510] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:25817; }","duration":"165.636612ms","start":"2026-06-10T02:06:42.077632Z","end":"2026-06-10T02:06:42.243268Z","steps":["trace[1633250510] 'count revisions from in-memory index tree' (duration: 165.365146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:42.243679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.007503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T02:06:42.243705Z","caller":"traceutil/trace.go:171","msg":"trace[1552819865] range","detail":"{range_begin:/registry/runtime.cluster.x-k8s.io/extensionconfigs/; range_end:/registry/runtime.cluster.x-k8s.io/extensionconfigs0; response_count:0; response_revision:25817; }","duration":"141.038263ms","start":"2026-06-10T02:06:42.102656Z","end":"2026-06-10T02:06:42.243694Z","steps":["trace[1552819865] 'count revisions from in-memory index tree' (duration: 140.949522ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:42.245035Z","caller":"traceutil/trace.go:171","msg":"trace[1564474423] transaction","detail":"{read_only:false; response_revision:25818; number_of_response:1; }","duration":"127.46719ms","start":"2026-06-10T02:06:42.117554Z","end":"2026-06-10T02:06:42.245022Z","steps":["trace[1564474423] 'process raft request' (duration: 112.740732ms)","trace[1564474423] 'compare' (duration: 12.616525ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:42.442146Z","caller":"traceutil/trace.go:171","msg":"trace[1093966996] transaction","detail":"{read_only:false; response_revision:25819; number_of_response:1; }","duration":"135.765776ms","start":"2026-06-10T02:06:42.30635Z","end":"2026-06-10T02:06:42.442116Z","steps":["trace[1093966996] 'process raft request' (duration: 49.275776ms)","trace[1093966996] 'compare' (duration: 86.208155ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:51.753766Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22992} {"level":"warn","ts":"2026-06-10T02:06:51.75468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.014057ms","expected-duration":"100ms","prefix":"","request":"header: compaction: ","response":"size:6"} {"level":"info","ts":"2026-06-10T02:06:51.754946Z","caller":"traceutil/trace.go:171","msg":"trace[1579655622] compact","detail":"{revision:22992; response_revision:25883; }","duration":"223.747448ms","start":"2026-06-10T02:06:51.531169Z","end":"2026-06-10T02:06:51.754917Z","steps":["trace[1579655622] 'process raft request' (duration: 65.304581ms)","trace[1579655622] 'check and update compact revision' (duration: 156.858034ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:51.755693Z","caller":"traceutil/trace.go:171","msg":"trace[1701528640] transaction","detail":"{read_only:false; response_revision:25884; number_of_response:1; }","duration":"221.162376ms","start":"2026-06-10T02:06:51.534507Z","end":"2026-06-10T02:06:51.755669Z","steps":["trace[1701528640] 'process raft request' (duration: 220.341718ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:51.756265Z","caller":"traceutil/trace.go:171","msg":"trace[119344138] transaction","detail":"{read_only:false; response_revision:25885; number_of_response:1; }","duration":"221.637605ms","start":"2026-06-10T02:06:51.534606Z","end":"2026-06-10T02:06:51.756244Z","steps":["trace[119344138] 'process raft request' (duration: 221.045863ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:51.757033Z","caller":"traceutil/trace.go:171","msg":"trace[80300275] transaction","detail":"{read_only:false; response_revision:25886; number_of_response:1; }","duration":"221.704246ms","start":"2026-06-10T02:06:51.535297Z","end":"2026-06-10T02:06:51.757001Z","steps":["trace[80300275] 'process raft request' (duration: 220.932951ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:51.757886Z","caller":"traceutil/trace.go:171","msg":"trace[226239310] transaction","detail":"{read_only:false; response_revision:25887; number_of_response:1; }","duration":"221.790228ms","start":"2026-06-10T02:06:51.536078Z","end":"2026-06-10T02:06:51.757868Z","steps":["trace[226239310] 'process raft request' (duration: 220.89981ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:51.758144Z","caller":"traceutil/trace.go:171","msg":"trace[1591521473] transaction","detail":"{read_only:false; response_revision:25888; number_of_response:1; }","duration":"192.451744ms","start":"2026-06-10T02:06:51.565672Z","end":"2026-06-10T02:06:51.758124Z","steps":["trace[1591521473] 'process raft request' (duration: 192.183839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:06:51.912651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.339081ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T02:06:51.91292Z","caller":"traceutil/trace.go:171","msg":"trace[158229130] linearizableReadLoop","detail":"{readStateIndex:26732; appliedIndex:26730; }","duration":"167.687323ms","start":"2026-06-10T02:06:51.745212Z","end":"2026-06-10T02:06:51.912899Z","steps":["trace[158229130] 'read index received' (duration: 22.970064ms)","trace[158229130] 'applied index is now lower than readState.Index' (duration: 144.716029ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:06:51.913154Z","caller":"traceutil/trace.go:171","msg":"trace[883747685] transaction","detail":"{read_only:false; response_revision:25890; number_of_response:1; }","duration":"173.661454ms","start":"2026-06-10T02:06:51.739442Z","end":"2026-06-10T02:06:51.913103Z","steps":["trace[883747685] 'process raft request' (duration: 173.361848ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:51.913189Z","caller":"traceutil/trace.go:171","msg":"trace[1867805631] transaction","detail":"{read_only:false; response_revision:25889; number_of_response:1; }","duration":"185.515284ms","start":"2026-06-10T02:06:51.727649Z","end":"2026-06-10T02:06:51.913165Z","steps":["trace[1867805631] 'process raft request' (duration: 40.52061ms)","trace[1867805631] 'compare' (duration: 144.000075ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:06:51.913241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.028821ms","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:8"} {"level":"info","ts":"2026-06-10T02:06:51.913531Z","caller":"traceutil/trace.go:171","msg":"trace[2089477286] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25890; }","duration":"168.349637ms","start":"2026-06-10T02:06:51.745155Z","end":"2026-06-10T02:06:51.913504Z","steps":["trace[2089477286] 'agreement among raft nodes before linearized reading' (duration: 168.028461ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:06:52.127245Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22992,"took":"365.967654ms","hash":1114863451,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":35373056,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-10T02:06:52.127301Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1114863451,"revision":22992,"compact-revision":20097} {"level":"info","ts":"2026-06-10T02:07:26.542078Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a1e.wal"} {"level":"info","ts":"2026-06-10T02:08:34.4095Z","caller":"traceutil/trace.go:171","msg":"trace[186326565] transaction","detail":"{read_only:false; response_revision:26915; number_of_response:1; }","duration":"106.150168ms","start":"2026-06-10T02:08:34.3033Z","end":"2026-06-10T02:08:34.40945Z","steps":["trace[186326565] 'process raft request' (duration: 105.935724ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:11:51.768185Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25883} {"level":"info","ts":"2026-06-10T02:11:51.922392Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25883,"took":"149.388666ms","hash":670124245,"current-db-size-bytes":60022784,"current-db-size":"60 MB","current-db-size-in-use-bytes":37744640,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-06-10T02:11:51.922465Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":670124245,"revision":25883,"compact-revision":22992} {"level":"info","ts":"2026-06-10T02:11:54.60787Z","caller":"traceutil/trace.go:171","msg":"trace[1452000940] transaction","detail":"{read_only:false; response_revision:28779; number_of_response:1; }","duration":"225.816481ms","start":"2026-06-10T02:11:54.382015Z","end":"2026-06-10T02:11:54.607831Z","steps":["trace[1452000940] 'process raft request' (duration: 136.382635ms)","trace[1452000940] 'compare' (duration: 89.155139ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:11:54.608399Z","caller":"traceutil/trace.go:171","msg":"trace[1874716833] transaction","detail":"{read_only:false; response_revision:28780; number_of_response:1; }","duration":"219.042334ms","start":"2026-06-10T02:11:54.389326Z","end":"2026-06-10T02:11:54.608369Z","steps":["trace[1874716833] 'process raft request' (duration: 218.42545ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:12:35.374828Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e46287fb5aa4785","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T02:12:35.380685Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-10T02:12:35.380952Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"warn","ts":"2026-06-10T02:15:03.284139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.406922ms","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":"info","ts":"2026-06-10T02:15:03.284226Z","caller":"traceutil/trace.go:171","msg":"trace[1876153926] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:30168; }","duration":"579.535764ms","start":"2026-06-10T02:15:02.704667Z","end":"2026-06-10T02:15:03.284203Z","steps":["trace[1876153926] 'range keys from in-memory index tree' (duration: 579.245428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T02:15:03.284259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:15:02.704648Z","time spent":"579.600016ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-10T02:15:03.286224Z","caller":"traceutil/trace.go:171","msg":"trace[221928970] linearizableReadLoop","detail":"{readStateIndex:31124; appliedIndex:31123; }","duration":"250.341826ms","start":"2026-06-10T02:15:03.035846Z","end":"2026-06-10T02:15:03.286188Z","steps":["trace[221928970] 'read index received' (duration: 228.227449ms)","trace[221928970] 'applied index is now lower than readState.Index' (duration: 22.113547ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T02:15:03.286244Z","caller":"traceutil/trace.go:171","msg":"trace[2098914420] transaction","detail":"{read_only:false; response_revision:30169; number_of_response:1; }","duration":"564.086813ms","start":"2026-06-10T02:15:02.72213Z","end":"2026-06-10T02:15:03.286217Z","steps":["trace[2098914420] 'process raft request' (duration: 542.011497ms)","trace[2098914420] 'compare' (duration: 20.652126ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T02:15:03.286479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T02:15:02.722112Z","time spent":"564.194694ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T02:15:03.286633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.787916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:38 size:316877"} {"level":"info","ts":"2026-06-10T02:15:03.286655Z","caller":"traceutil/trace.go:171","msg":"trace[875176687] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:38; response_revision:30169; }","duration":"250.875387ms","start":"2026-06-10T02:15:03.035773Z","end":"2026-06-10T02:15:03.286649Z","steps":["trace[875176687] 'agreement among raft nodes before linearized reading' (duration: 250.51592ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T02:16:51.778841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28761} {"level":"info","ts":"2026-06-10T02:16:51.918559Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28761,"took":"134.276671ms","hash":3312550889,"current-db-size-bytes":60022784,"current-db-size":"60 MB","current-db-size-in-use-bytes":30720000,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T02:16:51.918637Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3312550889,"revision":28761,"compact-revision":25883} {"level":"info","ts":"2026-06-10T02:21:51.786897Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30978} {"level":"info","ts":"2026-06-10T02:21:51.92081Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30978,"took":"129.033396ms","hash":3525503379,"current-db-size-bytes":60022784,"current-db-size":"60 MB","current-db-size-in-use-bytes":30269440,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T02:21:51.920903Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3525503379,"revision":30978,"compact-revision":28761} {"level":"info","ts":"2026-06-10T02:26:51.794224Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33243} {"level":"info","ts":"2026-06-10T02:26:51.949574Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33243,"took":"151.128482ms","hash":1691366644,"current-db-size-bytes":61067264,"current-db-size":"61 MB","current-db-size-in-use-bytes":31272960,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T02:26:51.949693Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1691366644,"revision":33243,"compact-revision":30978} {"level":"info","ts":"2026-06-10T02:31:51.80411Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35535} {"level":"info","ts":"2026-06-10T02:31:51.970446Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35535,"took":"159.86088ms","hash":323860431,"current-db-size-bytes":62386176,"current-db-size":"62 MB","current-db-size-in-use-bytes":31444992,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T02:31:51.97055Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":323860431,"revision":35535,"compact-revision":33243} {"level":"info","ts":"2026-06-10T02:34:07.115925Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e46287fb5aa4785","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T02:34:07.122402Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-10T02:34:07.122523Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-10T02:36:51.80994Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37761} {"level":"info","ts":"2026-06-10T02:36:51.925634Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37761,"took":"108.696296ms","hash":1431066183,"current-db-size-bytes":62386176,"current-db-size":"62 MB","current-db-size-in-use-bytes":32301056,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T02:36:51.925681Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1431066183,"revision":37761,"compact-revision":35535}