{"level":"warn","ts":"2026-04-17T00:33:41.542977Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T00:33:41.543075Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-04-17T00:33:41.543145Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T00:33:41.543156Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-04-17T00:33:41.543176Z","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-04-17T00:33:41.54384Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-04-17T00:33:41.54393Z","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.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-04-17T00:33:41.54778Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.631058ms"} {"level":"info","ts":"2026-04-17T00:33:41.553067Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-04-17T00:33:41.553151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T00:33:41.553175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-04-17T00:33:41.553186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T00:33:41.553204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-04-17T00:33:41.553243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-04-17T00:33:41.566034Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T00:33:41.567886Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T00:33:41.569298Z","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-04-17T00:33:41.57364Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T00:33:41.573929Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T00:33:41.573971Z","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-04-17T00:33:41.57407Z","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-04-17T00:33:41.574085Z","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-04-17T00:33:41.57512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-04-17T00:33:41.575335Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-04-17T00:33:41.578762Z","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-04-17T00:33:41.578868Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-04-17T00:33:41.578914Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-04-17T00:33:41.579163Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T00:33:41.579244Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T00:33:41.653902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T00:33:41.653964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T00:33:41.653997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-04-17T00:33:41.654017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-04-17T00:33:41.654029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-04-17T00:33:41.654046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-04-17T00:33:41.654065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-04-17T00:33:41.654953Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:33:41.655987Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T00:33:41.656039Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:33:41.656081Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:33:41.656333Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T00:33:41.656398Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T00:33:41.656475Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:33:41.656622Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:33:41.656676Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:33:41.659833Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-04-17T00:33:41.660264Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T00:34:19.100874Z","caller":"traceutil/trace.go:171","msg":"trace[1732416387] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"147.833631ms","start":"2026-04-17T00:34:18.952996Z","end":"2026-04-17T00:34:19.10083Z","steps":["trace[1732416387] 'process raft request' (duration: 147.567314ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:19.190604Z","caller":"traceutil/trace.go:171","msg":"trace[47127004] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:637; }","duration":"128.689365ms","start":"2026-04-17T00:34:19.061878Z","end":"2026-04-17T00:34:19.190568Z","steps":["trace[47127004] 'read index received' (duration: 38.722506ms)","trace[47127004] 'applied index is now lower than readState.Index' (duration: 89.965498ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:34:19.190698Z","caller":"traceutil/trace.go:171","msg":"trace[1181257258] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"208.097057ms","start":"2026-04-17T00:34:18.982545Z","end":"2026-04-17T00:34:19.190642Z","steps":["trace[1181257258] 'process raft request' (duration: 207.221613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:34:19.190844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.926591ms","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-04-17T00:34:19.191044Z","caller":"traceutil/trace.go:171","msg":"trace[1452015931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"129.183477ms","start":"2026-04-17T00:34:19.061835Z","end":"2026-04-17T00:34:19.191018Z","steps":["trace[1452015931] 'agreement among raft nodes before linearized reading' (duration: 128.854189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:34:19.908671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.680471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:34:19.90878Z","caller":"traceutil/trace.go:171","msg":"trace[1092708641] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"181.588302ms","start":"2026-04-17T00:34:19.727175Z","end":"2026-04-17T00:34:19.908763Z","steps":["trace[1092708641] 'read index received' (duration: 82.122µs)","trace[1092708641] 'applied index is now lower than readState.Index' (duration: 181.50479ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:34:19.908862Z","caller":"traceutil/trace.go:171","msg":"trace[1940377443] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"660.669136ms","start":"2026-04-17T00:34:19.248183Z","end":"2026-04-17T00:34:19.908852Z","steps":["trace[1940377443] 'process raft request' (duration: 184.240564ms)","trace[1940377443] 'compare' (duration: 475.503217ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:34:19.908911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:34:19.248154Z","time spent":"660.733338ms","remote":"127.0.0.1:39502","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-04-17T00:34:19.909269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.096747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T00:34:19.909309Z","caller":"traceutil/trace.go:171","msg":"trace[503243756] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:621; }","duration":"182.185409ms","start":"2026-04-17T00:34:19.727113Z","end":"2026-04-17T00:34:19.909298Z","steps":["trace[503243756] 'agreement among raft nodes before linearized reading' (duration: 182.035305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:34:19.909466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.517469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:34:19.909569Z","caller":"traceutil/trace.go:171","msg":"trace[2021363351] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"132.671713ms","start":"2026-04-17T00:34:19.776871Z","end":"2026-04-17T00:34:19.909543Z","steps":["trace[2021363351] 'agreement among raft nodes before linearized reading' (duration: 132.496078ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:21.198184Z","caller":"traceutil/trace.go:171","msg":"trace[387171653] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"113.501694ms","start":"2026-04-17T00:34:21.084614Z","end":"2026-04-17T00:34:21.198116Z","steps":["trace[387171653] 'process raft request' (duration: 92.789395ms)","trace[387171653] 'compare' (duration: 20.458623ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:34:21.198236Z","caller":"traceutil/trace.go:171","msg":"trace[1172059032] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"109.839305ms","start":"2026-04-17T00:34:21.088373Z","end":"2026-04-17T00:34:21.198212Z","steps":["trace[1172059032] 'process raft request' (duration: 109.608139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:34:34.182557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.308746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-17T00:34:34.18265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.721177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rdf7b\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-04-17T00:34:34.182649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.932251ms","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-04-17T00:34:34.182654Z","caller":"traceutil/trace.go:171","msg":"trace[1218855790] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:779; }","duration":"157.46919ms","start":"2026-04-17T00:34:34.025165Z","end":"2026-04-17T00:34:34.182634Z","steps":["trace[1218855790] 'range keys from in-memory index tree' (duration: 157.0667ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:34.182739Z","caller":"traceutil/trace.go:171","msg":"trace[1457993342] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rdf7b; range_end:; response_count:1; response_revision:779; }","duration":"141.86196ms","start":"2026-04-17T00:34:34.040857Z","end":"2026-04-17T00:34:34.182719Z","steps":["trace[1457993342] 'range keys from in-memory index tree' (duration: 141.563972ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:34.182751Z","caller":"traceutil/trace.go:171","msg":"trace[1491447067] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:779; }","duration":"159.100475ms","start":"2026-04-17T00:34:34.023632Z","end":"2026-04-17T00:34:34.182733Z","steps":["trace[1491447067] 'range keys from in-memory index tree' (duration: 158.722895ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:35:47.652498Z","caller":"traceutil/trace.go:171","msg":"trace[1072100003] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"195.96344ms","start":"2026-04-17T00:35:47.456271Z","end":"2026-04-17T00:35:47.652234Z","steps":["trace[1072100003] 'process raft request' (duration: 195.560558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:36:39.927191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.030464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:36:39.927333Z","caller":"traceutil/trace.go:171","msg":"trace[2085711433] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2168; }","duration":"151.22572ms","start":"2026-04-17T00:36:39.776081Z","end":"2026-04-17T00:36:39.927307Z","steps":["trace[2085711433] 'range keys from in-memory index tree' (duration: 150.926742ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:36:40.062719Z","caller":"traceutil/trace.go:171","msg":"trace[1157085486] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2246; }","duration":"100.465723ms","start":"2026-04-17T00:36:39.962228Z","end":"2026-04-17T00:36:40.062694Z","steps":["trace[1157085486] 'read index received' (duration: 100.246077ms)","trace[1157085486] 'applied index is now lower than readState.Index' (duration: 218.346µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:36:40.062881Z","caller":"traceutil/trace.go:171","msg":"trace[1073788053] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"127.298832ms","start":"2026-04-17T00:36:39.935565Z","end":"2026-04-17T00:36:40.062864Z","steps":["trace[1073788053] 'process raft request' (duration: 126.969633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:36:40.063195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.930166ms","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-04-17T00:36:40.063338Z","caller":"traceutil/trace.go:171","msg":"trace[1534460815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2169; }","duration":"101.106151ms","start":"2026-04-17T00:36:39.96221Z","end":"2026-04-17T00:36:40.063316Z","steps":["trace[1534460815] 'agreement among raft nodes before linearized reading' (duration: 100.796833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:36:40.347244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.520892ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:36:40.347531Z","caller":"traceutil/trace.go:171","msg":"trace[976711537] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"279.586041ms","start":"2026-04-17T00:36:40.067904Z","end":"2026-04-17T00:36:40.34749Z","steps":["trace[976711537] 'process raft request' (duration: 279.467188ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:36:40.347676Z","caller":"traceutil/trace.go:171","msg":"trace[1009679626] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"279.663413ms","start":"2026-04-17T00:36:40.06798Z","end":"2026-04-17T00:36:40.347643Z","steps":["trace[1009679626] 'process raft request' (duration: 279.456417ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:36:40.347784Z","caller":"traceutil/trace.go:171","msg":"trace[1474686716] linearizableReadLoop","detail":"{readStateIndex:2250; appliedIndex:2247; }","duration":"136.137133ms","start":"2026-04-17T00:36:40.211593Z","end":"2026-04-17T00:36:40.34773Z","steps":["trace[1474686716] 'read index received' (duration: 44.991µs)","trace[1474686716] 'applied index is now lower than readState.Index' (duration: 135.908757ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:36:40.347531Z","caller":"traceutil/trace.go:171","msg":"trace[1565185141] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"279.795418ms","start":"2026-04-17T00:36:40.067668Z","end":"2026-04-17T00:36:40.347463Z","steps":["trace[1565185141] 'process raft request' (duration: 72.769233ms)","trace[1565185141] 'compare' (duration: 206.420549ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:36:40.392287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.667079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:36:40.392389Z","caller":"traceutil/trace.go:171","msg":"trace[985166746] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:2172; }","duration":"180.833213ms","start":"2026-04-17T00:36:40.211532Z","end":"2026-04-17T00:36:40.392365Z","steps":["trace[985166746] 'agreement among raft nodes before linearized reading' (duration: 136.121013ms)","trace[985166746] 'count revisions from in-memory index tree' (duration: 44.535795ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:36:40.392717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.097859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-17T00:36:40.392886Z","caller":"traceutil/trace.go:171","msg":"trace[1407748679] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2173; }","duration":"122.313495ms","start":"2026-04-17T00:36:40.270545Z","end":"2026-04-17T00:36:40.392858Z","steps":["trace[1407748679] 'agreement among raft nodes before linearized reading' (duration: 121.80086ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:38.51628Z","caller":"traceutil/trace.go:171","msg":"trace[693647500] transaction","detail":"{read_only:false; response_revision:3832; number_of_response:1; }","duration":"154.093784ms","start":"2026-04-17T00:40:38.362165Z","end":"2026-04-17T00:40:38.516258Z","steps":["trace[693647500] 'process raft request' (duration: 153.96258ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:38.627865Z","caller":"traceutil/trace.go:171","msg":"trace[849828363] transaction","detail":"{read_only:false; response_revision:3833; number_of_response:1; }","duration":"103.746086ms","start":"2026-04-17T00:40:38.52409Z","end":"2026-04-17T00:40:38.627836Z","steps":["trace[849828363] 'process raft request' (duration: 93.627133ms)","trace[849828363] 'compare' (duration: 10.01204ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:42:01.544772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.138197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:42:01.544896Z","caller":"traceutil/trace.go:171","msg":"trace[1437501022] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:4845; }","duration":"121.297231ms","start":"2026-04-17T00:42:01.423576Z","end":"2026-04-17T00:42:01.544874Z","steps":["trace[1437501022] 'count revisions from in-memory index tree' (duration: 121.060104ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:05.008518Z","caller":"traceutil/trace.go:171","msg":"trace[1926032038] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5005; }","duration":"135.7149ms","start":"2026-04-17T00:42:04.872782Z","end":"2026-04-17T00:42:05.008497Z","steps":["trace[1926032038] 'process raft request' (duration: 135.643538ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:05.12894Z","caller":"traceutil/trace.go:171","msg":"trace[2057754129] linearizableReadLoop","detail":"{readStateIndex:5194; appliedIndex:5193; }","duration":"119.280494ms","start":"2026-04-17T00:42:05.009633Z","end":"2026-04-17T00:42:05.128914Z","steps":["trace[2057754129] 'read index received' (duration: 119.040787ms)","trace[2057754129] 'applied index is now lower than readState.Index' (duration: 238.217µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:05.128995Z","caller":"traceutil/trace.go:171","msg":"trace[882483816] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"191.766367ms","start":"2026-04-17T00:42:04.937195Z","end":"2026-04-17T00:42:05.128962Z","steps":["trace[882483816] 'process raft request' (duration: 191.546571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:05.129205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.553681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/monitoring\" ","response":"range_response_count:1 size:372"} {"level":"info","ts":"2026-04-17T00:42:05.129248Z","caller":"traceutil/trace.go:171","msg":"trace[140027313] range","detail":"{range_begin:/registry/namespaces/monitoring; range_end:; response_count:1; response_revision:5006; }","duration":"119.655854ms","start":"2026-04-17T00:42:05.009582Z","end":"2026-04-17T00:42:05.129238Z","steps":["trace[140027313] 'agreement among raft nodes before linearized reading' (duration: 119.474269ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:05.580076Z","caller":"traceutil/trace.go:171","msg":"trace[896422767] linearizableReadLoop","detail":"{readStateIndex:5207; appliedIndex:5205; }","duration":"185.122514ms","start":"2026-04-17T00:42:05.394928Z","end":"2026-04-17T00:42:05.580051Z","steps":["trace[896422767] 'read index received' (duration: 5.291717ms)","trace[896422767] 'applied index is now lower than readState.Index' (duration: 179.829717ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:05.580162Z","caller":"traceutil/trace.go:171","msg":"trace[1464831303] transaction","detail":"{read_only:false; response_revision:5018; number_of_response:1; }","duration":"203.062192ms","start":"2026-04-17T00:42:05.377056Z","end":"2026-04-17T00:42:05.580119Z","steps":["trace[1464831303] 'process raft request' (duration: 202.748683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:05.580633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.605357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d32ae350-1f0b-4095-b5e0-fd7f95322d4c\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-17T00:42:05.580779Z","caller":"traceutil/trace.go:171","msg":"trace[2105724022] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d32ae350-1f0b-4095-b5e0-fd7f95322d4c; range_end:; response_count:1; response_revision:5018; }","duration":"185.810172ms","start":"2026-04-17T00:42:05.39492Z","end":"2026-04-17T00:42:05.580731Z","steps":["trace[2105724022] 'agreement among raft nodes before linearized reading' (duration: 185.262637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:05.591063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.826889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-csrds-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-04-17T00:42:05.591118Z","caller":"traceutil/trace.go:171","msg":"trace[15175025] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-csrds-tls; range_end:; response_count:1; response_revision:5020; }","duration":"146.948883ms","start":"2026-04-17T00:42:05.444157Z","end":"2026-04-17T00:42:05.591106Z","steps":["trace[15175025] 'agreement among raft nodes before linearized reading' (duration: 146.751117ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:05.591155Z","caller":"traceutil/trace.go:171","msg":"trace[240299122] transaction","detail":"{read_only:false; response_revision:5019; number_of_response:1; }","duration":"184.009683ms","start":"2026-04-17T00:42:05.407101Z","end":"2026-04-17T00:42:05.591111Z","steps":["trace[240299122] 'process raft request' (duration: 183.676574ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:05.591171Z","caller":"traceutil/trace.go:171","msg":"trace[1091098802] transaction","detail":"{read_only:false; response_revision:5020; number_of_response:1; }","duration":"144.299959ms","start":"2026-04-17T00:42:05.446848Z","end":"2026-04-17T00:42:05.591148Z","steps":["trace[1091098802] 'process raft request' (duration: 144.011671ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:13.00801Z","caller":"traceutil/trace.go:171","msg":"trace[1162387373] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"101.356927ms","start":"2026-04-17T00:42:12.90663Z","end":"2026-04-17T00:42:13.007987Z","steps":["trace[1162387373] 'process raft request' (duration: 101.059059ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:16.080654Z","caller":"traceutil/trace.go:171","msg":"trace[2009816964] linearizableReadLoop","detail":"{readStateIndex:5426; appliedIndex:5425; }","duration":"130.512906ms","start":"2026-04-17T00:42:15.950122Z","end":"2026-04-17T00:42:16.080635Z","steps":["trace[2009816964] 'read index received' (duration: 130.257989ms)","trace[2009816964] 'applied index is now lower than readState.Index' (duration: 254.147µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:16.080686Z","caller":"traceutil/trace.go:171","msg":"trace[1053888326] transaction","detail":"{read_only:false; response_revision:5230; number_of_response:1; }","duration":"198.238068ms","start":"2026-04-17T00:42:15.882422Z","end":"2026-04-17T00:42:16.08066Z","steps":["trace[1053888326] 'process raft request' (duration: 197.98708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:16.080872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.735353ms","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-04-17T00:42:16.080903Z","caller":"traceutil/trace.go:171","msg":"trace[783675341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5230; }","duration":"130.814945ms","start":"2026-04-17T00:42:15.950078Z","end":"2026-04-17T00:42:16.080893Z","steps":["trace[783675341] 'agreement among raft nodes before linearized reading' (duration: 130.659801ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:25.979498Z","caller":"traceutil/trace.go:171","msg":"trace[358438545] linearizableReadLoop","detail":"{readStateIndex:5612; appliedIndex:5611; }","duration":"110.712425ms","start":"2026-04-17T00:42:25.868764Z","end":"2026-04-17T00:42:25.979477Z","steps":["trace[358438545] 'read index received' (duration: 110.5292ms)","trace[358438545] 'applied index is now lower than readState.Index' (duration: 182.345µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:25.979654Z","caller":"traceutil/trace.go:171","msg":"trace[179620410] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"116.145797ms","start":"2026-04-17T00:42:25.863471Z","end":"2026-04-17T00:42:25.979617Z","steps":["trace[179620410] 'process raft request' (duration: 115.87749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:25.979717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.941202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e98ac176-0904-4cc2-8411-4ec1f1199c3a\" ","response":"range_response_count:1 size:3939"} {"level":"info","ts":"2026-04-17T00:42:25.979804Z","caller":"traceutil/trace.go:171","msg":"trace[117743487] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e98ac176-0904-4cc2-8411-4ec1f1199c3a; range_end:; response_count:1; response_revision:5414; }","duration":"111.041195ms","start":"2026-04-17T00:42:25.868708Z","end":"2026-04-17T00:42:25.979749Z","steps":["trace[117743487] 'agreement among raft nodes before linearized reading' (duration: 110.86949ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:34.074945Z","caller":"traceutil/trace.go:171","msg":"trace[1110397703] linearizableReadLoop","detail":"{readStateIndex:5751; appliedIndex:5750; }","duration":"300.623443ms","start":"2026-04-17T00:42:33.774296Z","end":"2026-04-17T00:42:34.07492Z","steps":["trace[1110397703] 'read index received' (duration: 300.494449ms)","trace[1110397703] 'applied index is now lower than readState.Index' (duration: 127.964µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:34.074995Z","caller":"traceutil/trace.go:171","msg":"trace[1028076142] transaction","detail":"{read_only:false; response_revision:5548; number_of_response:1; }","duration":"311.836344ms","start":"2026-04-17T00:42:33.763122Z","end":"2026-04-17T00:42:34.074959Z","steps":["trace[1028076142] 'process raft request' (duration: 311.614048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.075169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:33.763084Z","time spent":"311.981798ms","remote":"127.0.0.1:39182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10667,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:42:34.075164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.852568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-17T00:42:34.075363Z","caller":"traceutil/trace.go:171","msg":"trace[113102166] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5548; }","duration":"301.098555ms","start":"2026-04-17T00:42:33.774248Z","end":"2026-04-17T00:42:34.075347Z","steps":["trace[113102166] 'agreement among raft nodes before linearized reading' (duration: 300.778047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.075413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:33.774232Z","time spent":"301.167518ms","remote":"127.0.0.1:39150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-17T00:42:34.589499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.503875ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:42:34.589927Z","caller":"traceutil/trace.go:171","msg":"trace[626206128] transaction","detail":"{read_only:false; response_revision:5549; number_of_response:1; }","duration":"587.078662ms","start":"2026-04-17T00:42:34.002814Z","end":"2026-04-17T00:42:34.589892Z","steps":["trace[626206128] 'process raft request' (duration: 451.071553ms)","trace[626206128] 'compare' (duration: 135.147294ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:34.590026Z","caller":"traceutil/trace.go:171","msg":"trace[385338858] linearizableReadLoop","detail":"{readStateIndex:5752; appliedIndex:5751; }","duration":"511.03044ms","start":"2026-04-17T00:42:34.078962Z","end":"2026-04-17T00:42:34.589993Z","steps":["trace[385338858] 'read index received' (duration: 374.939128ms)","trace[385338858] 'applied index is now lower than readState.Index' (duration: 136.087522ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:42:34.590083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.002784Z","time spent":"587.223086ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:42:34.590247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.282376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-e98ac176-0904-4cc2-8411-4ec1f1199c3a\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-04-17T00:42:34.590452Z","caller":"traceutil/trace.go:171","msg":"trace[1293380608] range","detail":"{range_begin:/registry/persistentvolumes/pvc-e98ac176-0904-4cc2-8411-4ec1f1199c3a; range_end:; response_count:1; response_revision:5550; }","duration":"511.535353ms","start":"2026-04-17T00:42:34.078907Z","end":"2026-04-17T00:42:34.590442Z","steps":["trace[1293380608] 'agreement among raft nodes before linearized reading' (duration: 511.166173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.59049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.078886Z","time spent":"511.595685ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1345,"request content":"key:\"/registry/persistentvolumes/pvc-e98ac176-0904-4cc2-8411-4ec1f1199c3a\" "} {"level":"info","ts":"2026-04-17T00:42:34.59054Z","caller":"traceutil/trace.go:171","msg":"trace[1583378219] transaction","detail":"{read_only:false; response_revision:5551; number_of_response:1; }","duration":"508.562091ms","start":"2026-04-17T00:42:34.081911Z","end":"2026-04-17T00:42:34.590473Z","steps":["trace[1583378219] 'process raft request' (duration: 508.409447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.590724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.081898Z","time spent":"508.730525ms","remote":"127.0.0.1:39282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1428,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:42:34.590724Z","caller":"traceutil/trace.go:171","msg":"trace[211191425] transaction","detail":"{read_only:false; response_revision:5552; number_of_response:1; }","duration":"508.319414ms","start":"2026-04-17T00:42:34.082384Z","end":"2026-04-17T00:42:34.590703Z","steps":["trace[211191425] 'process raft request' (duration: 507.996245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.590835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.082375Z","time spent":"508.404266ms","remote":"127.0.0.1:39282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1505,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:42:34.59093Z","caller":"traceutil/trace.go:171","msg":"trace[934685850] transaction","detail":"{read_only:false; response_revision:5550; number_of_response:1; }","duration":"509.374453ms","start":"2026-04-17T00:42:34.081525Z","end":"2026-04-17T00:42:34.5909Z","steps":["trace[934685850] 'process raft request' (duration: 508.090658ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:34.591031Z","caller":"traceutil/trace.go:171","msg":"trace[123195553] transaction","detail":"{read_only:false; response_revision:5554; number_of_response:1; }","duration":"392.081124ms","start":"2026-04-17T00:42:34.198942Z","end":"2026-04-17T00:42:34.591023Z","steps":["trace[123195553] 'process raft request' (duration: 391.859978ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:34.591022Z","caller":"traceutil/trace.go:171","msg":"trace[590954817] transaction","detail":"{read_only:false; response_revision:5553; number_of_response:1; }","duration":"508.376415ms","start":"2026-04-17T00:42:34.082596Z","end":"2026-04-17T00:42:34.590973Z","steps":["trace[590954817] 'process raft request' (duration: 507.82135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.591092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.08151Z","time spent":"509.498817ms","remote":"127.0.0.1:39158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:42:34.591088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.198925Z","time spent":"392.135135ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:42:34.591195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.082587Z","time spent":"508.519149ms","remote":"127.0.0.1:39158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:42:34.591254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.979854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17208"} {"level":"info","ts":"2026-04-17T00:42:34.59132Z","caller":"traceutil/trace.go:171","msg":"trace[1343227377] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5555; }","duration":"413.083617ms","start":"2026-04-17T00:42:34.178218Z","end":"2026-04-17T00:42:34.591302Z","steps":["trace[1343227377] 'agreement among raft nodes before linearized reading' (duration: 412.893802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.591372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.178196Z","time spent":"413.16351ms","remote":"127.0.0.1:39182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":17231,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-04-17T00:42:34.591446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.022174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pmn8l\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-17T00:42:34.591477Z","caller":"traceutil/trace.go:171","msg":"trace[209224139] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pmn8l; range_end:; response_count:1; response_revision:5555; }","duration":"116.083305ms","start":"2026-04-17T00:42:34.475388Z","end":"2026-04-17T00:42:34.591472Z","steps":["trace[209224139] 'agreement among raft nodes before linearized reading' (duration: 115.940971ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:34.591624Z","caller":"traceutil/trace.go:171","msg":"trace[287934619] transaction","detail":"{read_only:false; response_revision:5555; number_of_response:1; }","duration":"279.264888ms","start":"2026-04-17T00:42:34.312307Z","end":"2026-04-17T00:42:34.591572Z","steps":["trace[287934619] 'process raft request' (duration: 278.661802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.591643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.37241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-17T00:42:34.591643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.516428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-17T00:42:34.591687Z","caller":"traceutil/trace.go:171","msg":"trace[573901288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5555; }","duration":"325.443332ms","start":"2026-04-17T00:42:34.266231Z","end":"2026-04-17T00:42:34.591674Z","steps":["trace[573901288] 'agreement among raft nodes before linearized reading' (duration: 325.310519ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:34.591719Z","caller":"traceutil/trace.go:171","msg":"trace[950160001] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5555; }","duration":"233.622951ms","start":"2026-04-17T00:42:34.358071Z","end":"2026-04-17T00:42:34.591694Z","steps":["trace[950160001] 'agreement among raft nodes before linearized reading' (duration: 233.384664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.591755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.266219Z","time spent":"325.525615ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T00:42:34.591622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.509658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T00:42:34.591962Z","caller":"traceutil/trace.go:171","msg":"trace[1276039026] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5555; }","duration":"319.781225ms","start":"2026-04-17T00:42:34.272068Z","end":"2026-04-17T00:42:34.591849Z","steps":["trace[1276039026] 'agreement among raft nodes before linearized reading' (duration: 319.500657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.592037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.608217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-17T00:42:34.591939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.12304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-17T00:42:34.592106Z","caller":"traceutil/trace.go:171","msg":"trace[1134511219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5555; }","duration":"325.73272ms","start":"2026-04-17T00:42:34.266333Z","end":"2026-04-17T00:42:34.592066Z","steps":["trace[1134511219] 'agreement among raft nodes before linearized reading' (duration: 325.176105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.592148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.266308Z","time spent":"325.832413ms","remote":"127.0.0.1:39268","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":"info","ts":"2026-04-17T00:42:34.592211Z","caller":"traceutil/trace.go:171","msg":"trace[1187445117] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5555; }","duration":"322.331486ms","start":"2026-04-17T00:42:34.269803Z","end":"2026-04-17T00:42:34.592135Z","steps":["trace[1187445117] 'agreement among raft nodes before linearized reading' (duration: 321.593996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.592292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.272057Z","time spent":"319.96677ms","remote":"127.0.0.1:51962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-17T00:42:34.592302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.269794Z","time spent":"322.496402ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-17T00:42:34.901022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.873764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:42:34.901133Z","caller":"traceutil/trace.go:171","msg":"trace[340016368] linearizableReadLoop","detail":"{readStateIndex:5759; appliedIndex:5758; }","duration":"304.271745ms","start":"2026-04-17T00:42:34.596844Z","end":"2026-04-17T00:42:34.901116Z","steps":["trace[340016368] 'read index received' (duration: 127.291177ms)","trace[340016368] 'applied index is now lower than readState.Index' (duration: 176.979458ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:34.901324Z","caller":"traceutil/trace.go:171","msg":"trace[108448533] transaction","detail":"{read_only:false; response_revision:5556; number_of_response:1; }","duration":"305.901929ms","start":"2026-04-17T00:42:34.595408Z","end":"2026-04-17T00:42:34.90131Z","steps":["trace[108448533] 'process raft request' (duration: 128.633694ms)","trace[108448533] 'compare' (duration: 176.772141ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:42:34.901398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.595385Z","time spent":"305.975091ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:42:34.901617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.749368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:81832"} {"level":"info","ts":"2026-04-17T00:42:34.901733Z","caller":"traceutil/trace.go:171","msg":"trace[468529552] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5556; }","duration":"304.897312ms","start":"2026-04-17T00:42:34.596818Z","end":"2026-04-17T00:42:34.901715Z","steps":["trace[468529552] 'agreement among raft nodes before linearized reading' (duration: 304.522032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.901789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.596805Z","time spent":"304.971634ms","remote":"127.0.0.1:39182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":9,"response size":81855,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-04-17T00:42:34.925771Z","caller":"traceutil/trace.go:171","msg":"trace[1331344891] transaction","detail":"{read_only:false; response_revision:5557; number_of_response:1; }","duration":"328.606451ms","start":"2026-04-17T00:42:34.597139Z","end":"2026-04-17T00:42:34.925745Z","steps":["trace[1331344891] 'process raft request' (duration: 328.412505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.925955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.597129Z","time spent":"328.734254ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:42:34.926192Z","caller":"traceutil/trace.go:171","msg":"trace[1877145544] transaction","detail":"{read_only:false; response_revision:5558; number_of_response:1; }","duration":"328.96972ms","start":"2026-04-17T00:42:34.597193Z","end":"2026-04-17T00:42:34.926162Z","steps":["trace[1877145544] 'process raft request' (duration: 328.503868ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:34.926245Z","caller":"traceutil/trace.go:171","msg":"trace[891840499] transaction","detail":"{read_only:false; response_revision:5559; number_of_response:1; }","duration":"328.93205ms","start":"2026-04-17T00:42:34.597277Z","end":"2026-04-17T00:42:34.926209Z","steps":["trace[891840499] 'process raft request' (duration: 328.697333ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:34.92638Z","caller":"traceutil/trace.go:171","msg":"trace[386933720] transaction","detail":"{read_only:false; response_revision:5560; number_of_response:1; }","duration":"328.9149ms","start":"2026-04-17T00:42:34.59744Z","end":"2026-04-17T00:42:34.926355Z","steps":["trace[386933720] 'process raft request' (duration: 328.688924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.926485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.597176Z","time spent":"329.133966ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:42:34.926524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.597433Z","time spent":"329.010582ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:42:34.926564Z","caller":"traceutil/trace.go:171","msg":"trace[306807693] transaction","detail":"{read_only:false; response_revision:5562; number_of_response:1; }","duration":"319.479597ms","start":"2026-04-17T00:42:34.607068Z","end":"2026-04-17T00:42:34.926548Z","steps":["trace[306807693] 'process raft request' (duration: 319.301922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.926638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.60705Z","time spent":"319.545908ms","remote":"127.0.0.1:39182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:42:34.926645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.091271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:42:34.926698Z","caller":"traceutil/trace.go:171","msg":"trace[1323640918] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5562; }","duration":"150.223894ms","start":"2026-04-17T00:42:34.77646Z","end":"2026-04-17T00:42:34.926684Z","steps":["trace[1323640918] 'agreement among raft nodes before linearized reading' (duration: 150.09299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.92666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.053474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T00:42:34.926763Z","caller":"traceutil/trace.go:171","msg":"trace[748926856] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:5562; }","duration":"279.203577ms","start":"2026-04-17T00:42:34.647541Z","end":"2026-04-17T00:42:34.926744Z","steps":["trace[748926856] 'agreement among raft nodes before linearized reading' (duration: 279.024393ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:34.926796Z","caller":"traceutil/trace.go:171","msg":"trace[369695420] transaction","detail":"{read_only:false; response_revision:5561; number_of_response:1; }","duration":"329.337921ms","start":"2026-04-17T00:42:34.597447Z","end":"2026-04-17T00:42:34.926785Z","steps":["trace[369695420] 'process raft request' (duration: 328.838667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.926848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.597406Z","time spent":"329.415164ms","remote":"127.0.0.1:39268","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-04-17T00:42:34.926494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.597255Z","time spent":"329.104395ms","remote":"127.0.0.1:39268","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-04-17T00:42:34.926533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.146505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-02dd0c84-7c41-4277-8019-8bca25e011a4\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-04-17T00:42:34.927164Z","caller":"traceutil/trace.go:171","msg":"trace[604368414] range","detail":"{range_begin:/registry/persistentvolumes/pvc-02dd0c84-7c41-4277-8019-8bca25e011a4; range_end:; response_count:1; response_revision:5562; }","duration":"329.789684ms","start":"2026-04-17T00:42:34.59736Z","end":"2026-04-17T00:42:34.92715Z","steps":["trace[604368414] 'agreement among raft nodes before linearized reading' (duration: 329.072254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:34.927212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:34.597355Z","time spent":"329.845435ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1458,"request content":"key:\"/registry/persistentvolumes/pvc-02dd0c84-7c41-4277-8019-8bca25e011a4\" "} {"level":"info","ts":"2026-04-17T00:42:35.092605Z","caller":"traceutil/trace.go:171","msg":"trace[240805449] transaction","detail":"{read_only:false; response_revision:5564; number_of_response:1; }","duration":"125.807695ms","start":"2026-04-17T00:42:34.966745Z","end":"2026-04-17T00:42:35.092553Z","steps":["trace[240805449] 'process raft request' (duration: 89.2541ms)","trace[240805449] 'compare' (duration: 36.35731ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:35.092779Z","caller":"traceutil/trace.go:171","msg":"trace[1417881462] transaction","detail":"{read_only:false; response_revision:5565; number_of_response:1; }","duration":"125.084405ms","start":"2026-04-17T00:42:34.967668Z","end":"2026-04-17T00:42:35.092753Z","steps":["trace[1417881462] 'process raft request' (duration: 124.819058ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:35.092864Z","caller":"traceutil/trace.go:171","msg":"trace[1166451075] transaction","detail":"{read_only:false; response_revision:5566; number_of_response:1; }","duration":"125.087855ms","start":"2026-04-17T00:42:34.967735Z","end":"2026-04-17T00:42:35.092823Z","steps":["trace[1166451075] 'process raft request' (duration: 124.810567ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:35.09288Z","caller":"traceutil/trace.go:171","msg":"trace[922325712] transaction","detail":"{read_only:false; response_revision:5568; number_of_response:1; }","duration":"116.590729ms","start":"2026-04-17T00:42:34.976262Z","end":"2026-04-17T00:42:35.092853Z","steps":["trace[922325712] 'process raft request' (duration: 116.439714ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:35.092971Z","caller":"traceutil/trace.go:171","msg":"trace[927929442] transaction","detail":"{read_only:false; response_revision:5567; number_of_response:1; }","duration":"124.901809ms","start":"2026-04-17T00:42:34.968057Z","end":"2026-04-17T00:42:35.092959Z","steps":["trace[927929442] 'process raft request' (duration: 124.55218ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:43:42.07135Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3025} {"level":"info","ts":"2026-04-17T00:43:42.16417Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3025,"took":"91.05219ms","hash":3655608659,"current-db-size-bytes":58925056,"current-db-size":"59 MB","current-db-size-in-use-bytes":31744000,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-17T00:43:42.16425Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3655608659,"revision":3025,"compact-revision":-1} {"level":"info","ts":"2026-04-17T00:48:31.211028Z","caller":"traceutil/trace.go:171","msg":"trace[1471171814] transaction","detail":"{read_only:false; response_revision:8244; number_of_response:1; }","duration":"253.457225ms","start":"2026-04-17T00:48:30.95754Z","end":"2026-04-17T00:48:31.210997Z","steps":["trace[1471171814] 'process raft request' (duration: 253.281701ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:48:31.363267Z","caller":"traceutil/trace.go:171","msg":"trace[1308003435] transaction","detail":"{read_only:false; response_revision:8246; number_of_response:1; }","duration":"404.873213ms","start":"2026-04-17T00:48:30.958357Z","end":"2026-04-17T00:48:31.36323Z","steps":["trace[1308003435] 'process raft request' (duration: 404.7759ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:48:31.36366Z","caller":"traceutil/trace.go:171","msg":"trace[376406759] transaction","detail":"{read_only:false; response_revision:8247; number_of_response:1; }","duration":"405.237083ms","start":"2026-04-17T00:48:30.958383Z","end":"2026-04-17T00:48:31.36362Z","steps":["trace[376406759] 'process raft request' (duration: 404.798481ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:48:31.363803Z","caller":"traceutil/trace.go:171","msg":"trace[1492098077] transaction","detail":"{read_only:false; response_revision:8248; number_of_response:1; }","duration":"405.023817ms","start":"2026-04-17T00:48:30.95875Z","end":"2026-04-17T00:48:31.363773Z","steps":["trace[1492098077] 'process raft request' (duration: 404.76857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:48:31.36387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:48:30.958362Z","time spent":"405.393197ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:48:31.363277Z","caller":"traceutil/trace.go:171","msg":"trace[1000561574] transaction","detail":"{read_only:false; response_revision:8245; number_of_response:1; }","duration":"405.198032ms","start":"2026-04-17T00:48:30.958039Z","end":"2026-04-17T00:48:31.363237Z","steps":["trace[1000561574] 'process raft request' (duration: 404.899684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:48:31.363964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:48:30.958723Z","time spent":"405.137969ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:48:31.363996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:48:30.958008Z","time spent":"405.923481ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:48:31.363684Z","caller":"traceutil/trace.go:171","msg":"trace[1263614156] linearizableReadLoop","detail":"{readStateIndex:8537; appliedIndex:8532; }","duration":"285.135929ms","start":"2026-04-17T00:48:31.078526Z","end":"2026-04-17T00:48:31.363662Z","steps":["trace[1263614156] 'read index received' (duration: 132.432167ms)","trace[1263614156] 'applied index is now lower than readState.Index' (duration: 152.702442ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:48:31.364097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.550931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pmn8l\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-17T00:48:31.36433Z","caller":"traceutil/trace.go:171","msg":"trace[89336489] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pmn8l; range_end:; response_count:1; response_revision:8248; }","duration":"285.844109ms","start":"2026-04-17T00:48:31.07847Z","end":"2026-04-17T00:48:31.364315Z","steps":["trace[89336489] 'agreement among raft nodes before linearized reading' (duration: 285.259563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:48:31.364254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.985855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T00:48:31.364476Z","caller":"traceutil/trace.go:171","msg":"trace[828623207] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8248; }","duration":"263.237502ms","start":"2026-04-17T00:48:31.101217Z","end":"2026-04-17T00:48:31.364454Z","steps":["trace[828623207] 'agreement among raft nodes before linearized reading' (duration: 262.959725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:48:31.364676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:48:30.958327Z","time spent":"405.358586ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:48:42.07964Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6129} {"level":"info","ts":"2026-04-17T00:48:42.187429Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6129,"took":"105.539946ms","hash":3261538462,"current-db-size-bytes":58925056,"current-db-size":"59 MB","current-db-size-in-use-bytes":23117824,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-17T00:48:42.187503Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3261538462,"revision":6129,"compact-revision":3025} {"level":"info","ts":"2026-04-17T00:48:42.944675Z","caller":"traceutil/trace.go:171","msg":"trace[1480727768] linearizableReadLoop","detail":"{readStateIndex:8598; appliedIndex:8597; }","duration":"160.578535ms","start":"2026-04-17T00:48:42.784071Z","end":"2026-04-17T00:48:42.944649Z","steps":["trace[1480727768] 'read index received' (duration: 160.220415ms)","trace[1480727768] 'applied index is now lower than readState.Index' (duration: 356.58µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:48:42.944765Z","caller":"traceutil/trace.go:171","msg":"trace[222817020] transaction","detail":"{read_only:false; response_revision:8305; number_of_response:1; }","duration":"249.011265ms","start":"2026-04-17T00:48:42.695708Z","end":"2026-04-17T00:48:42.944719Z","steps":["trace[222817020] 'process raft request' (duration: 248.716057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:48:42.944857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.766861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:48:42.944905Z","caller":"traceutil/trace.go:171","msg":"trace[742013855] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8305; }","duration":"160.890485ms","start":"2026-04-17T00:48:42.784004Z","end":"2026-04-17T00:48:42.944894Z","steps":["trace[742013855] 'agreement among raft nodes before linearized reading' (duration: 160.797502ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:48:43.065804Z","caller":"traceutil/trace.go:171","msg":"trace[1879893474] transaction","detail":"{read_only:false; response_revision:8306; number_of_response:1; }","duration":"116.487934ms","start":"2026-04-17T00:48:42.949291Z","end":"2026-04-17T00:48:43.065779Z","steps":["trace[1879893474] 'process raft request' (duration: 85.619113ms)","trace[1879893474] 'compare' (duration: 30.723737ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:48:43.801052Z","caller":"traceutil/trace.go:171","msg":"trace[567660321] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"237.769598ms","start":"2026-04-17T00:48:43.563245Z","end":"2026-04-17T00:48:43.801014Z","steps":["trace[567660321] 'process raft request' (duration: 195.257609ms)","trace[567660321] 'compare' (duration: 42.271032ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:49:12.717782Z","caller":"traceutil/trace.go:171","msg":"trace[1261197356] linearizableReadLoop","detail":"{readStateIndex:8820; appliedIndex:8819; }","duration":"296.651623ms","start":"2026-04-17T00:49:12.421098Z","end":"2026-04-17T00:49:12.71775Z","steps":["trace[1261197356] 'read index received' (duration: 296.376576ms)","trace[1261197356] 'applied index is now lower than readState.Index' (duration: 274.147µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:49:12.71795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.827808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:49:12.717903Z","caller":"traceutil/trace.go:171","msg":"trace[2007164355] transaction","detail":"{read_only:false; response_revision:8519; number_of_response:1; }","duration":"331.43757ms","start":"2026-04-17T00:49:12.386418Z","end":"2026-04-17T00:49:12.717856Z","steps":["trace[2007164355] 'process raft request' (duration: 331.153993ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:49:12.717988Z","caller":"traceutil/trace.go:171","msg":"trace[379841936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8519; }","duration":"296.924961ms","start":"2026-04-17T00:49:12.421053Z","end":"2026-04-17T00:49:12.717978Z","steps":["trace[379841936] 'agreement among raft nodes before linearized reading' (duration: 296.831968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:49:12.718129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:49:12.386392Z","time spent":"331.620975ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:49:12.923915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.297628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:49:12.924004Z","caller":"traceutil/trace.go:171","msg":"trace[1427015904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8519; }","duration":"149.459112ms","start":"2026-04-17T00:49:12.774523Z","end":"2026-04-17T00:49:12.923983Z","steps":["trace[1427015904] 'range keys from in-memory index tree' (duration: 149.078472ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:49:15.678455Z","caller":"traceutil/trace.go:171","msg":"trace[1106671375] transaction","detail":"{read_only:false; response_revision:8533; number_of_response:1; }","duration":"121.684726ms","start":"2026-04-17T00:49:15.556724Z","end":"2026-04-17T00:49:15.678409Z","steps":["trace[1106671375] 'process raft request' (duration: 121.45024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:49:25.640936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.52428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:49:25.641056Z","caller":"traceutil/trace.go:171","msg":"trace[1177963755] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:8628; }","duration":"198.696004ms","start":"2026-04-17T00:49:25.442333Z","end":"2026-04-17T00:49:25.641029Z","steps":["trace[1177963755] 'count revisions from in-memory index tree' (duration: 198.380026ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:49:46.964495Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023eb.wal"} {"level":"info","ts":"2026-04-17T00:51:18.890772Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"380f6760faea5f9e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-17T00:51:18.899467Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-17T00:51:18.899565Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-17T00:53:42.090049Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8302} {"level":"info","ts":"2026-04-17T00:53:42.175847Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8302,"took":"82.605061ms","hash":2971815698,"current-db-size-bytes":58925056,"current-db-size":"59 MB","current-db-size-in-use-bytes":24858624,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-17T00:53:42.175922Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2971815698,"revision":8302,"compact-revision":6129} {"level":"info","ts":"2026-04-17T00:58:42.098594Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10703} {"level":"info","ts":"2026-04-17T00:58:42.184132Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10703,"took":"82.938996ms","hash":218562061,"current-db-size-bytes":58925056,"current-db-size":"59 MB","current-db-size-in-use-bytes":20373504,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-17T00:58:42.184265Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":218562061,"revision":10703,"compact-revision":8302} {"level":"warn","ts":"2026-04-17T00:59:13.222703Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890117759768278675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:59:13.723711Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890117759768278675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:59:14.224552Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890117759768278675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:59:14.725126Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890117759768278675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:59:14.776631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000323472s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-17T00:59:14.776726Z","caller":"traceutil/trace.go:171","msg":"trace[218120016] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000457066s","start":"2026-04-17T00:59:12.776238Z","end":"2026-04-17T00:59:14.776695Z","steps":["trace[218120016] 'agreement among raft nodes before linearized reading' (duration: 2.000319182s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:14.776792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:12.776206Z","time spent":"2.000573279s","remote":"127.0.0.1:39024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/17 00:59:14 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-17T00:59:15.225763Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890117759768278675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:59:15.356211Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.635024097s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T00:59:15.35693Z","caller":"traceutil/trace.go:171","msg":"trace[1120215253] transaction","detail":"{read_only:false; response_revision:12402; number_of_response:1; }","duration":"2.6358524s","start":"2026-04-17T00:59:12.721041Z","end":"2026-04-17T00:59:15.356893Z","steps":["trace[1120215253] 'process raft request' (duration: 2.635654135s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.357137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:12.721008Z","time spent":"2.636024545s","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:59:15.365124Z","caller":"traceutil/trace.go:171","msg":"trace[820616294] transaction","detail":"{read_only:false; response_revision:12404; number_of_response:1; }","duration":"1.724545164s","start":"2026-04-17T00:59:13.640544Z","end":"2026-04-17T00:59:15.365089Z","steps":["trace[820616294] 'process raft request' (duration: 1.724445331s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:15.365186Z","caller":"traceutil/trace.go:171","msg":"trace[759715588] transaction","detail":"{read_only:false; response_revision:12403; number_of_response:1; }","duration":"2.584828476s","start":"2026-04-17T00:59:12.780304Z","end":"2026-04-17T00:59:15.365132Z","steps":["trace[759715588] 'process raft request' (duration: 2.584502116s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.365318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:13.640513Z","time spent":"1.724684697s","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:59:15.365429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:12.780275Z","time spent":"2.585014081s","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:59:15.365599Z","caller":"traceutil/trace.go:171","msg":"trace[1193749992] transaction","detail":"{read_only:false; response_revision:12405; number_of_response:1; }","duration":"864.748653ms","start":"2026-04-17T00:59:14.500838Z","end":"2026-04-17T00:59:15.365586Z","steps":["trace[1193749992] 'process raft request' (duration: 864.207869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.365673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:14.500811Z","time spent":"864.824935ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:59:15.365898Z","caller":"traceutil/trace.go:171","msg":"trace[2076563277] linearizableReadLoop","detail":"{readStateIndex:12847; appliedIndex:12841; }","duration":"2.643432035s","start":"2026-04-17T00:59:12.722452Z","end":"2026-04-17T00:59:15.365884Z","steps":["trace[2076563277] 'read index received' (duration: 2.63433276s)","trace[2076563277] 'applied index is now lower than readState.Index' (duration: 9.097565ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:59:15.365929Z","caller":"traceutil/trace.go:171","msg":"trace[638505209] transaction","detail":"{read_only:false; response_revision:12406; number_of_response:1; }","duration":"610.892275ms","start":"2026-04-17T00:59:14.755019Z","end":"2026-04-17T00:59:15.365911Z","steps":["trace[638505209] 'process raft request' (duration: 610.512364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.365943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:14.780156Z","time spent":"585.776498ms","remote":"127.0.0.1:39100","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-17T00:59:15.366012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:14.754987Z","time spent":"610.983167ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:59:15.36615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.611313879s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/ceph-csi-config\" ","response":"range_response_count:1 size:703"} {"level":"warn","ts":"2026-04-17T00:59:15.366167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.23786154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-17T00:59:15.366147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.643672191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/ceph-etc\" ","response":"range_response_count:1 size:1155"} {"level":"info","ts":"2026-04-17T00:59:15.366208Z","caller":"traceutil/trace.go:171","msg":"trace[1512069817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12406; }","duration":"2.237923251s","start":"2026-04-17T00:59:13.128273Z","end":"2026-04-17T00:59:15.366196Z","steps":["trace[1512069817] 'agreement among raft nodes before linearized reading' (duration: 2.237825029s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.251528938s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-17T00:59:15.366244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:13.128258Z","time spent":"2.237979213s","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-17T00:59:15.366264Z","caller":"traceutil/trace.go:171","msg":"trace[2068616994] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12406; }","duration":"2.25159919s","start":"2026-04-17T00:59:13.114658Z","end":"2026-04-17T00:59:15.366257Z","steps":["trace[2068616994] 'agreement among raft nodes before linearized reading' (duration: 2.251557399s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:15.366256Z","caller":"traceutil/trace.go:171","msg":"trace[1432563999] range","detail":"{range_begin:/registry/configmaps/openstack/ceph-etc; range_end:; response_count:1; response_revision:12406; }","duration":"2.643833885s","start":"2026-04-17T00:59:12.722394Z","end":"2026-04-17T00:59:15.366228Z","steps":["trace[1432563999] 'agreement among raft nodes before linearized reading' (duration: 2.643562528s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:13.114634Z","time spent":"2.251647871s","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T00:59:15.366271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093997169s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-17T00:59:15.366287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.223636357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-17T00:59:15.366331Z","caller":"traceutil/trace.go:171","msg":"trace[1470687039] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:12406; }","duration":"1.094098651s","start":"2026-04-17T00:59:14.272215Z","end":"2026-04-17T00:59:15.366313Z","steps":["trace[1470687039] 'agreement among raft nodes before linearized reading' (duration: 1.093956927s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.573939433s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-17T00:59:15.366333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.068941774s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pmn8l\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-17T00:59:15.366305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.925971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-17T00:59:15.366372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:14.272191Z","time spent":"1.094172653s","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-04-17T00:59:15.366388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.234102428s","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-04-17T00:59:15.366387Z","caller":"traceutil/trace.go:171","msg":"trace[2109150981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12406; }","duration":"2.574021675s","start":"2026-04-17T00:59:12.79235Z","end":"2026-04-17T00:59:15.366372Z","steps":["trace[2109150981] 'agreement among raft nodes before linearized reading' (duration: 2.573936173s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.931281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:138"} {"level":"info","ts":"2026-04-17T00:59:15.366404Z","caller":"traceutil/trace.go:171","msg":"trace[859886182] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pmn8l; range_end:; response_count:1; response_revision:12406; }","duration":"1.069067847s","start":"2026-04-17T00:59:14.297316Z","end":"2026-04-17T00:59:15.366384Z","steps":["trace[859886182] 'agreement among raft nodes before linearized reading' (duration: 1.068825861s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:15.366428Z","caller":"traceutil/trace.go:171","msg":"trace[48149140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12406; }","duration":"2.234162469s","start":"2026-04-17T00:59:13.132256Z","end":"2026-04-17T00:59:15.366419Z","steps":["trace[48149140] 'agreement among raft nodes before linearized reading' (duration: 2.234062716s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:15.366442Z","caller":"traceutil/trace.go:171","msg":"trace[320845663] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:12406; }","duration":"169.015812ms","start":"2026-04-17T00:59:15.197415Z","end":"2026-04-17T00:59:15.366431Z","steps":["trace[320845663] 'agreement among raft nodes before linearized reading' (duration: 168.92495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:14.297294Z","time spent":"1.06914598s","remote":"127.0.0.1:39182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-pmn8l\" "} {"level":"warn","ts":"2026-04-17T00:59:15.36645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.58706531s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:59:15.366447Z","caller":"traceutil/trace.go:171","msg":"trace[1080095235] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:12406; }","duration":"642.144647ms","start":"2026-04-17T00:59:14.724268Z","end":"2026-04-17T00:59:15.366413Z","steps":["trace[1080095235] 'agreement among raft nodes before linearized reading' (duration: 641.828868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:13.132245Z","time spent":"2.234216751s","remote":"127.0.0.1:39268","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":"info","ts":"2026-04-17T00:59:15.366484Z","caller":"traceutil/trace.go:171","msg":"trace[1866562845] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:12406; }","duration":"1.587150011s","start":"2026-04-17T00:59:13.779323Z","end":"2026-04-17T00:59:15.366473Z","steps":["trace[1866562845] 'agreement among raft nodes before linearized reading' (duration: 1.58708723s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.021626355s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/staffeln-db-sync\" ","response":"range_response_count:1 size:5127"} {"level":"warn","ts":"2026-04-17T00:59:15.36631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:12.722374Z","time spent":"2.643926118s","remote":"127.0.0.1:39120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":1178,"request content":"key:\"/registry/configmaps/openstack/ceph-etc\" "} {"level":"info","ts":"2026-04-17T00:59:15.366564Z","caller":"traceutil/trace.go:171","msg":"trace[45709380] range","detail":"{range_begin:/registry/jobs/openstack/staffeln-db-sync; range_end:; response_count:1; response_revision:12406; }","duration":"2.021718958s","start":"2026-04-17T00:59:13.344833Z","end":"2026-04-17T00:59:15.366552Z","steps":["trace[45709380] 'agreement among raft nodes before linearized reading' (duration: 2.021623025s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:13.344805Z","time spent":"2.02178591s","remote":"127.0.0.1:39234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":5150,"request content":"key:\"/registry/jobs/openstack/staffeln-db-sync\" "} {"level":"warn","ts":"2026-04-17T00:59:15.366598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.274685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:59:15.366636Z","caller":"traceutil/trace.go:171","msg":"trace[2048308767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12406; }","duration":"582.361237ms","start":"2026-04-17T00:59:14.784265Z","end":"2026-04-17T00:59:15.366626Z","steps":["trace[2048308767] 'agreement among raft nodes before linearized reading' (duration: 582.301335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:14.784242Z","time spent":"582.422169ms","remote":"127.0.0.1:39034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T00:59:15.366435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:12.792338Z","time spent":"2.574089376s","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T00:59:15.366726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.222371292s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-17T00:59:15.366813Z","caller":"traceutil/trace.go:171","msg":"trace[764403640] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12406; }","duration":"2.222512616s","start":"2026-04-17T00:59:13.144275Z","end":"2026-04-17T00:59:15.366787Z","steps":["trace[764403640] 'agreement among raft nodes before linearized reading' (duration: 2.222261509s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:13.144246Z","time spent":"2.222619019s","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-17T00:59:15.366199Z","caller":"traceutil/trace.go:171","msg":"trace[420702096] range","detail":"{range_begin:/registry/configmaps/openstack/ceph-csi-config; range_end:; response_count:1; response_revision:12406; }","duration":"2.611430062s","start":"2026-04-17T00:59:12.754754Z","end":"2026-04-17T00:59:15.366184Z","steps":["trace[420702096] 'agreement among raft nodes before linearized reading' (duration: 2.611252197s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:12.754726Z","time spent":"2.612235503s","remote":"127.0.0.1:39120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":726,"request content":"key:\"/registry/configmaps/openstack/ceph-csi-config\" "} {"level":"warn","ts":"2026-04-17T00:59:15.367001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.549214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-17T00:59:15.36702Z","caller":"traceutil/trace.go:171","msg":"trace[2037338436] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:12406; }","duration":"855.607006ms","start":"2026-04-17T00:59:14.511407Z","end":"2026-04-17T00:59:15.367014Z","steps":["trace[2037338436] 'agreement among raft nodes before linearized reading' (duration: 854.927298ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:15.36638Z","caller":"traceutil/trace.go:171","msg":"trace[1002609771] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:12406; }","duration":"2.2237869s","start":"2026-04-17T00:59:13.142569Z","end":"2026-04-17T00:59:15.366356Z","steps":["trace[1002609771] 'agreement among raft nodes before linearized reading' (duration: 2.223488132s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.366117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.266239888s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-17T00:59:15.367038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:14.511395Z","time spent":"855.639297ms","remote":"127.0.0.1:39508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1116,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-04-17T00:59:15.367069Z","caller":"traceutil/trace.go:171","msg":"trace[1247264856] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:12406; }","duration":"1.267257955s","start":"2026-04-17T00:59:14.099799Z","end":"2026-04-17T00:59:15.367057Z","steps":["trace[1247264856] 'agreement among raft nodes before linearized reading' (duration: 1.266253868s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:15.367121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:14.099774Z","time spent":"1.267332646s","remote":"127.0.0.1:39124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":13,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-04-17T00:59:15.366513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:14.724243Z","time spent":"642.25709ms","remote":"127.0.0.1:39210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":30,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"warn","ts":"2026-04-17T00:59:15.37242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:13.14254Z","time spent":"2.229830823s","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-17T00:59:15.366525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:59:13.779307Z","time spent":"1.587208443s","remote":"127.0.0.1:60526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true "} {"level":"info","ts":"2026-04-17T00:59:17.561238Z","caller":"traceutil/trace.go:171","msg":"trace[986305704] transaction","detail":"{read_only:false; response_revision:12418; number_of_response:1; }","duration":"172.323812ms","start":"2026-04-17T00:59:17.388883Z","end":"2026-04-17T00:59:17.561207Z","steps":["trace[986305704] 'process raft request' (duration: 172.144736ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:17.564845Z","caller":"traceutil/trace.go:171","msg":"trace[741266217] linearizableReadLoop","detail":"{readStateIndex:12865; appliedIndex:12859; }","duration":"172.817635ms","start":"2026-04-17T00:59:17.392008Z","end":"2026-04-17T00:59:17.564826Z","steps":["trace[741266217] 'read index received' (duration: 169.007282ms)","trace[741266217] 'applied index is now lower than readState.Index' (duration: 3.809203ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:59:17.565204Z","caller":"traceutil/trace.go:171","msg":"trace[1101887124] transaction","detail":"{read_only:false; response_revision:12419; number_of_response:1; }","duration":"175.987161ms","start":"2026-04-17T00:59:17.389201Z","end":"2026-04-17T00:59:17.565189Z","steps":["trace[1101887124] 'process raft request' (duration: 175.360094ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:17.565479Z","caller":"traceutil/trace.go:171","msg":"trace[1407926465] transaction","detail":"{read_only:false; response_revision:12420; number_of_response:1; }","duration":"176.099593ms","start":"2026-04-17T00:59:17.389367Z","end":"2026-04-17T00:59:17.565467Z","steps":["trace[1407926465] 'process raft request' (duration: 175.293812ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:17.565718Z","caller":"traceutil/trace.go:171","msg":"trace[1730398055] transaction","detail":"{read_only:false; response_revision:12421; number_of_response:1; }","duration":"176.135524ms","start":"2026-04-17T00:59:17.389568Z","end":"2026-04-17T00:59:17.565704Z","steps":["trace[1730398055] 'process raft request' (duration: 175.133828ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:17.566006Z","caller":"traceutil/trace.go:171","msg":"trace[1009054552] transaction","detail":"{read_only:false; response_revision:12422; number_of_response:1; }","duration":"175.335972ms","start":"2026-04-17T00:59:17.390646Z","end":"2026-04-17T00:59:17.565982Z","steps":["trace[1009054552] 'process raft request' (duration: 174.103719ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:17.566306Z","caller":"traceutil/trace.go:171","msg":"trace[1635223927] transaction","detail":"{read_only:false; response_revision:12423; number_of_response:1; }","duration":"175.072825ms","start":"2026-04-17T00:59:17.391209Z","end":"2026-04-17T00:59:17.566282Z","steps":["trace[1635223927] 'process raft request' (duration: 173.580005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:17.567114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.078326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:41 size:375551"} {"level":"info","ts":"2026-04-17T00:59:17.567168Z","caller":"traceutil/trace.go:171","msg":"trace[324460837] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:41; response_revision:12423; }","duration":"175.167139ms","start":"2026-04-17T00:59:17.391989Z","end":"2026-04-17T00:59:17.567157Z","steps":["trace[324460837] 'agreement among raft nodes before linearized reading' (duration: 174.537861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:17.567611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.91455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/valkey-configuration\" ","response":"range_response_count:1 size:1828"} {"level":"info","ts":"2026-04-17T00:59:17.567653Z","caller":"traceutil/trace.go:171","msg":"trace[567887583] range","detail":"{range_begin:/registry/configmaps/openstack/valkey-configuration; range_end:; response_count:1; response_revision:12423; }","duration":"119.999803ms","start":"2026-04-17T00:59:17.447643Z","end":"2026-04-17T00:59:17.567643Z","steps":["trace[567887583] 'agreement among raft nodes before linearized reading' (duration: 119.923101ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:59:17.805063Z","caller":"traceutil/trace.go:171","msg":"trace[483430100] linearizableReadLoop","detail":"{readStateIndex:12866; appliedIndex:12865; }","duration":"119.828307ms","start":"2026-04-17T00:59:17.685207Z","end":"2026-04-17T00:59:17.805035Z","steps":["trace[483430100] 'read index received' (duration: 119.628261ms)","trace[483430100] 'applied index is now lower than readState.Index' (duration: 198.546µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:59:17.805421Z","caller":"traceutil/trace.go:171","msg":"trace[717371251] transaction","detail":"{read_only:false; response_revision:12424; number_of_response:1; }","duration":"125.453239ms","start":"2026-04-17T00:59:17.679921Z","end":"2026-04-17T00:59:17.805374Z","steps":["trace[717371251] 'process raft request' (duration: 124.904624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:59:17.807839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.609963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-fft2b.18a6fe964f0c2d4f\\000\" range_end:\"/registry/events/openstack0\" limit:1000 revision:12423 ","response":"range_response_count:101 size:78092"} {"level":"info","ts":"2026-04-17T00:59:17.807933Z","caller":"traceutil/trace.go:171","msg":"trace[2083717451] range","detail":"{range_begin:/registry/events/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-fft2b.18a6fe964f0c2d4f\u0000; range_end:/registry/events/openstack0; response_count:101; response_revision:12424; }","duration":"122.775067ms","start":"2026-04-17T00:59:17.685136Z","end":"2026-04-17T00:59:17.807911Z","steps":["trace[2083717451] 'agreement among raft nodes before linearized reading' (duration: 120.212988ms)"],"step_count":1}