{"level":"warn","ts":"2026-04-06T21:05:08.476298Z","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-06T21:05:08.476405Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-06T21:05:08.476497Z","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-06T21:05:08.476517Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-06T21:05:08.476541Z","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-06T21:05:08.477303Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-04-06T21:05:08.477394Z","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.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-06T21:05:08.482079Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.713593ms"} {"level":"info","ts":"2026-04-06T21:05:08.488214Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-04-06T21:05:08.488273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-04-06T21:05:08.488296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-04-06T21:05:08.488311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-06T21:05:08.488323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-04-06T21:05:08.48836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-04-06T21:05:08.500279Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-06T21:05:08.504896Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-06T21:05:08.506337Z","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-06T21:05:08.509272Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-06T21:05:08.509431Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-06T21:05:08.509436Z","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-06T21:05:08.509559Z","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-06T21:05:08.509576Z","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-06T21:05:08.510682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-04-06T21:05:08.510898Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-06T21:05:08.513414Z","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-06T21:05:08.51362Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-06T21:05:08.513708Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-06T21:05:08.513787Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-06T21:05:08.513854Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-06T21:05:08.588807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-04-06T21:05:08.588885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-06T21:05:08.588923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-04-06T21:05:08.588949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-04-06T21:05:08.588965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-06T21:05:08.588987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-04-06T21:05:08.589006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-06T21:05:08.58996Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-04-06T21:05:08.59Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T21:05:08.590035Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T21:05:08.590195Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-06T21:05:08.590153Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:05:08.590233Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-06T21:05:08.591033Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:05:08.591142Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:05:08.591173Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:05:08.593762Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-04-06T21:05:08.593939Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-06T21:05:34.297464Z","caller":"traceutil/trace.go:171","msg":"trace[773712613] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"171.912815ms","start":"2026-04-06T21:05:34.12553Z","end":"2026-04-06T21:05:34.297443Z","steps":["trace[773712613] 'process raft request' (duration: 171.773192ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:40.197895Z","caller":"traceutil/trace.go:171","msg":"trace[1010274349] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"103.236602ms","start":"2026-04-06T21:05:40.094629Z","end":"2026-04-06T21:05:40.197865Z","steps":["trace[1010274349] 'process raft request' (duration: 102.923935ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:40.572059Z","caller":"traceutil/trace.go:171","msg":"trace[1987658794] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"116.56962ms","start":"2026-04-06T21:05:40.455461Z","end":"2026-04-06T21:05:40.572031Z","steps":["trace[1987658794] 'read index received' (duration: 116.034819ms)","trace[1987658794] 'applied index is now lower than readState.Index' (duration: 533.841µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:05:40.572139Z","caller":"traceutil/trace.go:171","msg":"trace[2099221813] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"140.339005ms","start":"2026-04-06T21:05:40.431768Z","end":"2026-04-06T21:05:40.572107Z","steps":["trace[2099221813] 'process raft request' (duration: 139.814454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:40.572296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.808187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-04-06T21:05:40.572386Z","caller":"traceutil/trace.go:171","msg":"trace[976271914] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:584; }","duration":"116.939029ms","start":"2026-04-06T21:05:40.455431Z","end":"2026-04-06T21:05:40.57237Z","steps":["trace[976271914] 'agreement among raft nodes before linearized reading' (duration: 116.703904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:47.448846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.577086ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:05:47.449034Z","caller":"traceutil/trace.go:171","msg":"trace[1445226733] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"555.011357ms","start":"2026-04-06T21:05:46.893982Z","end":"2026-04-06T21:05:47.448993Z","steps":["trace[1445226733] 'process raft request' (duration: 308.47501ms)","trace[1445226733] 'compare' (duration: 245.33234ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:05:47.449171Z","caller":"traceutil/trace.go:171","msg":"trace[1907431371] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"456.473326ms","start":"2026-04-06T21:05:46.992646Z","end":"2026-04-06T21:05:47.44912Z","steps":["trace[1907431371] 'read index received' (duration: 209.827216ms)","trace[1907431371] 'applied index is now lower than readState.Index' (duration: 246.63978ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:05:47.449236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:46.893948Z","time spent":"555.164771ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:05:47.455484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.489728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-06T21:05:47.455521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.865228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vdkzn\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-06T21:05:47.455609Z","caller":"traceutil/trace.go:171","msg":"trace[453330749] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vdkzn; range_end:; response_count:1; response_revision:630; }","duration":"462.993791ms","start":"2026-04-06T21:05:46.992596Z","end":"2026-04-06T21:05:47.45559Z","steps":["trace[453330749] 'agreement among raft nodes before linearized reading' (duration: 456.735541ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:47.455604Z","caller":"traceutil/trace.go:171","msg":"trace[568496861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"350.638721ms","start":"2026-04-06T21:05:47.104945Z","end":"2026-04-06T21:05:47.455583Z","steps":["trace[568496861] 'agreement among raft nodes before linearized reading' (duration: 350.422197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:47.455653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:46.992572Z","time spent":"463.072393ms","remote":"127.0.0.1:34240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-vdkzn\" "} {"level":"warn","ts":"2026-04-06T21:05:47.455659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:47.104926Z","time spent":"350.723033ms","remote":"127.0.0.1:34322","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-06T21:05:47.45587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.842318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:05:47.456018Z","caller":"traceutil/trace.go:171","msg":"trace[1067097539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"164.180757ms","start":"2026-04-06T21:05:47.29181Z","end":"2026-04-06T21:05:47.455991Z","steps":["trace[1067097539] 'agreement among raft nodes before linearized reading' (duration: 163.661655ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:09.407047Z","caller":"traceutil/trace.go:171","msg":"trace[237987344] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"116.028531ms","start":"2026-04-06T21:06:09.290984Z","end":"2026-04-06T21:06:09.407013Z","steps":["trace[237987344] 'read index received' (duration: 115.755885ms)","trace[237987344] 'applied index is now lower than readState.Index' (duration: 271.696µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:06:09.407181Z","caller":"traceutil/trace.go:171","msg":"trace[1312994958] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"282.996361ms","start":"2026-04-06T21:06:09.12413Z","end":"2026-04-06T21:06:09.407127Z","steps":["trace[1312994958] 'process raft request' (duration: 282.687635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:09.407241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.255096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:06:09.407457Z","caller":"traceutil/trace.go:171","msg":"trace[470021137] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:805; }","duration":"116.483362ms","start":"2026-04-06T21:06:09.290917Z","end":"2026-04-06T21:06:09.4074Z","steps":["trace[470021137] 'agreement among raft nodes before linearized reading' (duration: 116.258406ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:08.61926Z","caller":"traceutil/trace.go:171","msg":"trace[1768734207] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"119.143168ms","start":"2026-04-06T21:07:08.500093Z","end":"2026-04-06T21:07:08.619236Z","steps":["trace[1768734207] 'process raft request' (duration: 118.997744ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:34.357191Z","caller":"traceutil/trace.go:171","msg":"trace[1903405074] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"330.064917ms","start":"2026-04-06T21:07:34.027089Z","end":"2026-04-06T21:07:34.357154Z","steps":["trace[1903405074] 'process raft request' (duration: 329.75429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:07:34.357367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:07:34.027068Z","time spent":"330.21104ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:07:34.357327Z","caller":"traceutil/trace.go:171","msg":"trace[1052092891] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"330.167949ms","start":"2026-04-06T21:07:34.027089Z","end":"2026-04-06T21:07:34.357257Z","steps":["trace[1052092891] 'process raft request' (duration: 329.953435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:07:34.357662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:07:34.027069Z","time spent":"330.473166ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:07:34.7492Z","caller":"traceutil/trace.go:171","msg":"trace[1506982449] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"188.315362ms","start":"2026-04-06T21:07:34.560833Z","end":"2026-04-06T21:07:34.749148Z","steps":["trace[1506982449] 'process raft request' (duration: 188.059286ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:34.871388Z","caller":"traceutil/trace.go:171","msg":"trace[1983913891] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"170.093975ms","start":"2026-04-06T21:07:34.701269Z","end":"2026-04-06T21:07:34.871363Z","steps":["trace[1983913891] 'process raft request' (duration: 170.040824ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:34.871415Z","caller":"traceutil/trace.go:171","msg":"trace[676779195] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"182.454362ms","start":"2026-04-06T21:07:34.688933Z","end":"2026-04-06T21:07:34.871387Z","steps":["trace[676779195] 'process raft request' (duration: 100.064013ms)","trace[676779195] 'compare' (duration: 82.094072ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:07:34.871438Z","caller":"traceutil/trace.go:171","msg":"trace[1137654355] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"170.3112ms","start":"2026-04-06T21:07:34.701098Z","end":"2026-04-06T21:07:34.871409Z","steps":["trace[1137654355] 'process raft request' (duration: 170.174067ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:47.031869Z","caller":"traceutil/trace.go:171","msg":"trace[2039576589] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"112.5026ms","start":"2026-04-06T21:07:46.919332Z","end":"2026-04-06T21:07:47.031835Z","steps":["trace[2039576589] 'process raft request' (duration: 112.288146ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:47.041715Z","caller":"traceutil/trace.go:171","msg":"trace[1103153380] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"120.625542ms","start":"2026-04-06T21:07:46.921071Z","end":"2026-04-06T21:07:47.041697Z","steps":["trace[1103153380] 'process raft request' (duration: 120.488189ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:47.041854Z","caller":"traceutil/trace.go:171","msg":"trace[1145704582] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"120.351356ms","start":"2026-04-06T21:07:46.921477Z","end":"2026-04-06T21:07:47.041828Z","steps":["trace[1145704582] 'process raft request' (duration: 120.178792ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:08:13.606056Z","caller":"traceutil/trace.go:171","msg":"trace[1896711848] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"112.05268ms","start":"2026-04-06T21:08:13.493962Z","end":"2026-04-06T21:08:13.606015Z","steps":["trace[1896711848] 'process raft request' (duration: 111.822104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:19.409349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.903009ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:08:19.409508Z","caller":"traceutil/trace.go:171","msg":"trace[1045681974] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2209; }","duration":"134.079983ms","start":"2026-04-06T21:08:19.275406Z","end":"2026-04-06T21:08:19.409486Z","steps":["trace[1045681974] 'range keys from in-memory index tree' (duration: 133.881548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:19.409615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.406552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:08:19.40971Z","caller":"traceutil/trace.go:171","msg":"trace[1249455360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2209; }","duration":"118.553935ms","start":"2026-04-06T21:08:19.291134Z","end":"2026-04-06T21:08:19.409688Z","steps":["trace[1249455360] 'range keys from in-memory index tree' (duration: 118.32322ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:08:24.951962Z","caller":"traceutil/trace.go:171","msg":"trace[1252408031] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"122.561705ms","start":"2026-04-06T21:08:24.829358Z","end":"2026-04-06T21:08:24.95192Z","steps":["trace[1252408031] 'process raft request' (duration: 122.373551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:26.038805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.793431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:08:26.039012Z","caller":"traceutil/trace.go:171","msg":"trace[664532615] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"311.810034ms","start":"2026-04-06T21:08:25.727181Z","end":"2026-04-06T21:08:26.038991Z","steps":["trace[664532615] 'process raft request' (duration: 121.746437ms)","trace[664532615] 'compare' (duration: 189.564875ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:08:26.039108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:08:25.727166Z","time spent":"311.908616ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:08:26.039959Z","caller":"traceutil/trace.go:171","msg":"trace[21598843] transaction","detail":"{read_only:false; response_revision:2242; number_of_response:1; }","duration":"309.763929ms","start":"2026-04-06T21:08:25.730163Z","end":"2026-04-06T21:08:26.039927Z","steps":["trace[21598843] 'process raft request' (duration: 309.456312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:26.040128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:08:25.73015Z","time spent":"309.886701ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:09:53.677853Z","caller":"traceutil/trace.go:171","msg":"trace[482974578] transaction","detail":"{read_only:false; response_revision:2907; number_of_response:1; }","duration":"175.949914ms","start":"2026-04-06T21:09:53.501867Z","end":"2026-04-06T21:09:53.677817Z","steps":["trace[482974578] 'process raft request' (duration: 175.695539ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:09:53.708188Z","caller":"traceutil/trace.go:171","msg":"trace[1149864329] transaction","detail":"{read_only:false; response_revision:2908; number_of_response:1; }","duration":"143.439694ms","start":"2026-04-06T21:09:53.564723Z","end":"2026-04-06T21:09:53.708163Z","steps":["trace[1149864329] 'process raft request' (duration: 129.507822ms)","trace[1149864329] 'compare' (duration: 13.773559ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:09:53.708517Z","caller":"traceutil/trace.go:171","msg":"trace[310025032] transaction","detail":"{read_only:false; response_revision:2909; number_of_response:1; }","duration":"140.318595ms","start":"2026-04-06T21:09:53.568173Z","end":"2026-04-06T21:09:53.708492Z","steps":["trace[310025032] 'process raft request' (duration: 139.957827ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:11:47.804834Z","caller":"traceutil/trace.go:171","msg":"trace[719327324] transaction","detail":"{read_only:false; response_revision:3638; number_of_response:1; }","duration":"108.937907ms","start":"2026-04-06T21:11:47.695864Z","end":"2026-04-06T21:11:47.804802Z","steps":["trace[719327324] 'process raft request' (duration: 68.42853ms)","trace[719327324] 'compare' (duration: 40.312942ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:11:47.806654Z","caller":"traceutil/trace.go:171","msg":"trace[427795024] transaction","detail":"{read_only:false; response_revision:3639; number_of_response:1; }","duration":"107.402453ms","start":"2026-04-06T21:11:47.699228Z","end":"2026-04-06T21:11:47.80663Z","steps":["trace[427795024] 'process raft request' (duration: 107.130037ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:19.409205Z","caller":"traceutil/trace.go:171","msg":"trace[232258208] linearizableReadLoop","detail":"{readStateIndex:4028; appliedIndex:4027; }","duration":"117.807921ms","start":"2026-04-06T21:12:19.291375Z","end":"2026-04-06T21:12:19.409183Z","steps":["trace[232258208] 'read index received' (duration: 117.653077ms)","trace[232258208] 'applied index is now lower than readState.Index' (duration: 153.833µs)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:12:19.409679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.282041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:12:19.40966Z","caller":"traceutil/trace.go:171","msg":"trace[2074862563] transaction","detail":"{read_only:false; response_revision:3877; number_of_response:1; }","duration":"118.904624ms","start":"2026-04-06T21:12:19.290717Z","end":"2026-04-06T21:12:19.409621Z","steps":["trace[2074862563] 'process raft request' (duration: 118.286941ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:19.409728Z","caller":"traceutil/trace.go:171","msg":"trace[622155977] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3877; }","duration":"118.377103ms","start":"2026-04-06T21:12:19.29134Z","end":"2026-04-06T21:12:19.409717Z","steps":["trace[622155977] 'agreement among raft nodes before linearized reading' (duration: 117.964504ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:19.577312Z","caller":"traceutil/trace.go:171","msg":"trace[1018046127] linearizableReadLoop","detail":"{readStateIndex:4029; appliedIndex:4028; }","duration":"168.000224ms","start":"2026-04-06T21:12:19.409283Z","end":"2026-04-06T21:12:19.577284Z","steps":["trace[1018046127] 'read index received' (duration: 164.226839ms)","trace[1018046127] 'applied index is now lower than readState.Index' (duration: 3.772115ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:12:19.577365Z","caller":"traceutil/trace.go:171","msg":"trace[1466354782] transaction","detail":"{read_only:false; response_revision:3878; number_of_response:1; }","duration":"284.014653ms","start":"2026-04-06T21:12:19.293294Z","end":"2026-04-06T21:12:19.577309Z","steps":["trace[1466354782] 'process raft request' (duration: 280.250119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:19.577451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.606258ms","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-06T21:12:19.577506Z","caller":"traceutil/trace.go:171","msg":"trace[784415044] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3878; }","duration":"242.69672ms","start":"2026-04-06T21:12:19.334795Z","end":"2026-04-06T21:12:19.577491Z","steps":["trace[784415044] 'agreement among raft nodes before linearized reading' (duration: 242.586768ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:41.421305Z","caller":"traceutil/trace.go:171","msg":"trace[601899855] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"105.232329ms","start":"2026-04-06T21:13:41.316027Z","end":"2026-04-06T21:13:41.42126Z","steps":["trace[601899855] 'process raft request' (duration: 40.456807ms)","trace[601899855] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/pods/local-path-storage/helper-pod-create-pvc-0a94e034-a8d6-461a-98f6-58f461eb99ba; req_size:4063; } (duration: 64.452195ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:13:43.16748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.761959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:13:43.167606Z","caller":"traceutil/trace.go:171","msg":"trace[1527917240] linearizableReadLoop","detail":"{readStateIndex:5219; appliedIndex:5218; }","duration":"176.489756ms","start":"2026-04-06T21:13:42.991101Z","end":"2026-04-06T21:13:43.16759Z","steps":["trace[1527917240] 'read index received' (duration: 13.454362ms)","trace[1527917240] 'applied index is now lower than readState.Index' (duration: 163.034374ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:13:43.16773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.607269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:13:43.167817Z","caller":"traceutil/trace.go:171","msg":"trace[1314914] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:5021; }","duration":"176.729242ms","start":"2026-04-06T21:13:42.991067Z","end":"2026-04-06T21:13:43.167796Z","steps":["trace[1314914] 'agreement among raft nodes before linearized reading' (duration: 176.597929ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:43.167865Z","caller":"traceutil/trace.go:171","msg":"trace[661909353] transaction","detail":"{read_only:false; response_revision:5021; number_of_response:1; }","duration":"212.150685ms","start":"2026-04-06T21:13:42.955687Z","end":"2026-04-06T21:13:43.167838Z","steps":["trace[661909353] 'process raft request' (duration: 48.938996ms)","trace[661909353] 'compare' (duration: 162.556124ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:13:54.104033Z","caller":"traceutil/trace.go:171","msg":"trace[40225272] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"121.498693ms","start":"2026-04-06T21:13:53.982505Z","end":"2026-04-06T21:13:54.104004Z","steps":["trace[40225272] 'process raft request' (duration: 99.654434ms)","trace[40225272] 'compare' (duration: 21.699226ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:14:01.732162Z","caller":"traceutil/trace.go:171","msg":"trace[1994704494] transaction","detail":"{read_only:false; response_revision:5411; number_of_response:1; }","duration":"202.767784ms","start":"2026-04-06T21:14:01.529363Z","end":"2026-04-06T21:14:01.73213Z","steps":["trace[1994704494] 'process raft request' (duration: 194.477518ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:01.768983Z","caller":"traceutil/trace.go:171","msg":"trace[653430385] transaction","detail":"{read_only:false; response_revision:5412; number_of_response:1; }","duration":"239.068838ms","start":"2026-04-06T21:14:01.529883Z","end":"2026-04-06T21:14:01.768952Z","steps":["trace[653430385] 'process raft request' (duration: 238.806293ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:01.768982Z","caller":"traceutil/trace.go:171","msg":"trace[1177350350] transaction","detail":"{read_only:false; response_revision:5413; number_of_response:1; }","duration":"238.629258ms","start":"2026-04-06T21:14:01.530326Z","end":"2026-04-06T21:14:01.768956Z","steps":["trace[1177350350] 'process raft request' (duration: 238.540736ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:01.76925Z","caller":"traceutil/trace.go:171","msg":"trace[1218335766] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"238.205249ms","start":"2026-04-06T21:14:01.531035Z","end":"2026-04-06T21:14:01.76924Z","steps":["trace[1218335766] 'process raft request' (duration: 237.881491ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:01.769314Z","caller":"traceutil/trace.go:171","msg":"trace[11201562] transaction","detail":"{read_only:false; response_revision:5415; number_of_response:1; }","duration":"237.536754ms","start":"2026-04-06T21:14:01.531769Z","end":"2026-04-06T21:14:01.769306Z","steps":["trace[11201562] 'process raft request' (duration: 237.34095ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:01.769292Z","caller":"traceutil/trace.go:171","msg":"trace[256862478] linearizableReadLoop","detail":"{readStateIndex:5619; appliedIndex:5617; }","duration":"239.11792ms","start":"2026-04-06T21:14:01.530146Z","end":"2026-04-06T21:14:01.769269Z","steps":["trace[256862478] 'read index received' (duration: 193.673491ms)","trace[256862478] 'applied index is now lower than readState.Index' (duration: 45.443399ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:14:01.769553Z","caller":"traceutil/trace.go:171","msg":"trace[800502049] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"234.444765ms","start":"2026-04-06T21:14:01.535095Z","end":"2026-04-06T21:14:01.76954Z","steps":["trace[800502049] 'process raft request' (duration: 234.125198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:01.769591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.446478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/monitoring/\" range_end:\"/registry/resourcequotas/monitoring0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:14:01.76965Z","caller":"traceutil/trace.go:171","msg":"trace[243825444] range","detail":"{range_begin:/registry/resourcequotas/monitoring/; range_end:/registry/resourcequotas/monitoring0; response_count:0; response_revision:5416; }","duration":"239.547749ms","start":"2026-04-06T21:14:01.530084Z","end":"2026-04-06T21:14:01.769632Z","steps":["trace[243825444] 'agreement among raft nodes before linearized reading' (duration: 239.421317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:01.769659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.927299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-04-06T21:14:01.769703Z","caller":"traceutil/trace.go:171","msg":"trace[1875896995] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5416; }","duration":"199.015591ms","start":"2026-04-06T21:14:01.570675Z","end":"2026-04-06T21:14:01.76969Z","steps":["trace[1875896995] 'agreement among raft nodes before linearized reading' (duration: 198.871127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:02.025941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.477075ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:14:02.026168Z","caller":"traceutil/trace.go:171","msg":"trace[335595504] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"250.147977ms","start":"2026-04-06T21:14:01.775974Z","end":"2026-04-06T21:14:02.026122Z","steps":["trace[335595504] 'process raft request' (duration: 69.395976ms)","trace[335595504] 'compare' (duration: 180.355822ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:14:02.026629Z","caller":"traceutil/trace.go:171","msg":"trace[263590829] transaction","detail":"{read_only:false; response_revision:5419; number_of_response:1; }","duration":"250.470014ms","start":"2026-04-06T21:14:01.776132Z","end":"2026-04-06T21:14:02.026602Z","steps":["trace[263590829] 'process raft request' (duration: 249.922722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:02.026796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.218975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-04-06T21:14:02.026856Z","caller":"traceutil/trace.go:171","msg":"trace[116815925] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5419; }","duration":"253.319499ms","start":"2026-04-06T21:14:01.773523Z","end":"2026-04-06T21:14:02.026842Z","steps":["trace[116815925] 'agreement among raft nodes before linearized reading' (duration: 253.093443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:02.026973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.922072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-results-cache-0\" ","response":"range_response_count:1 size:4473"} {"level":"info","ts":"2026-04-06T21:14:02.027023Z","caller":"traceutil/trace.go:171","msg":"trace[2111616274] linearizableReadLoop","detail":"{readStateIndex:5626; appliedIndex:5624; }","duration":"233.827901ms","start":"2026-04-06T21:14:01.792728Z","end":"2026-04-06T21:14:02.026555Z","steps":["trace[2111616274] 'read index received' (duration: 52.595439ms)","trace[2111616274] 'applied index is now lower than readState.Index' (duration: 181.230772ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:14:02.027069Z","caller":"traceutil/trace.go:171","msg":"trace[79931132] range","detail":"{range_begin:/registry/pods/monitoring/loki-results-cache-0; range_end:; response_count:1; response_revision:5419; }","duration":"254.042115ms","start":"2026-04-06T21:14:01.773006Z","end":"2026-04-06T21:14:02.027048Z","steps":["trace[79931132] 'agreement among raft nodes before linearized reading' (duration: 253.775408ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:03.777125Z","caller":"traceutil/trace.go:171","msg":"trace[217469924] transaction","detail":"{read_only:false; response_revision:5460; number_of_response:1; }","duration":"230.970817ms","start":"2026-04-06T21:14:03.546127Z","end":"2026-04-06T21:14:03.777098Z","steps":["trace[217469924] 'process raft request' (duration: 230.812994ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:13.968529Z","caller":"traceutil/trace.go:171","msg":"trace[342607784] linearizableReadLoop","detail":"{readStateIndex:5810; appliedIndex:5809; }","duration":"297.264454ms","start":"2026-04-06T21:14:13.67125Z","end":"2026-04-06T21:14:13.968515Z","steps":["trace[342607784] 'read index received' (duration: 297.156191ms)","trace[342607784] 'applied index is now lower than readState.Index' (duration: 107.533µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:14:13.968727Z","caller":"traceutil/trace.go:171","msg":"trace[168025261] transaction","detail":"{read_only:false; response_revision:5596; number_of_response:1; }","duration":"327.970491ms","start":"2026-04-06T21:14:13.640749Z","end":"2026-04-06T21:14:13.96872Z","steps":["trace[168025261] 'process raft request' (duration: 327.668774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:13.968791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:14:13.64073Z","time spent":"328.016563ms","remote":"127.0.0.1:34240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10669,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:14:13.969076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.798615ms","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-06T21:14:13.969152Z","caller":"traceutil/trace.go:171","msg":"trace[1601716332] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5596; }","duration":"297.909948ms","start":"2026-04-06T21:14:13.671221Z","end":"2026-04-06T21:14:13.969131Z","steps":["trace[1601716332] 'agreement among raft nodes before linearized reading' (duration: 297.674752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:14.099323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.722906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10684"} {"level":"info","ts":"2026-04-06T21:14:14.099393Z","caller":"traceutil/trace.go:171","msg":"trace[26164723] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5596; }","duration":"124.835429ms","start":"2026-04-06T21:14:13.974543Z","end":"2026-04-06T21:14:14.099379Z","steps":["trace[26164723] 'range keys from in-memory index tree' (duration: 124.635064ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:14.099618Z","caller":"traceutil/trace.go:171","msg":"trace[216485424] transaction","detail":"{read_only:false; response_revision:5600; number_of_response:1; }","duration":"123.739724ms","start":"2026-04-06T21:14:13.975855Z","end":"2026-04-06T21:14:14.099594Z","steps":["trace[216485424] 'process raft request' (duration: 123.693083ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:14.09982Z","caller":"traceutil/trace.go:171","msg":"trace[2077579792] transaction","detail":"{read_only:false; response_revision:5598; number_of_response:1; }","duration":"124.550251ms","start":"2026-04-06T21:14:13.975259Z","end":"2026-04-06T21:14:14.09981Z","steps":["trace[2077579792] 'process raft request' (duration: 124.171763ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:14.099855Z","caller":"traceutil/trace.go:171","msg":"trace[1712356704] transaction","detail":"{read_only:false; response_revision:5597; number_of_response:1; }","duration":"124.817367ms","start":"2026-04-06T21:14:13.975009Z","end":"2026-04-06T21:14:14.099827Z","steps":["trace[1712356704] 'process raft request' (duration: 101.253429ms)","trace[1712356704] 'compare' (duration: 23.038156ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:14:14.099884Z","caller":"traceutil/trace.go:171","msg":"trace[1907830254] transaction","detail":"{read_only:false; response_revision:5599; number_of_response:1; }","duration":"124.295836ms","start":"2026-04-06T21:14:13.975561Z","end":"2026-04-06T21:14:14.099857Z","steps":["trace[1907830254] 'process raft request' (duration: 123.928077ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:14.705082Z","caller":"traceutil/trace.go:171","msg":"trace[1010818847] linearizableReadLoop","detail":"{readStateIndex:5817; appliedIndex:5816; }","duration":"110.934616ms","start":"2026-04-06T21:14:14.594122Z","end":"2026-04-06T21:14:14.705057Z","steps":["trace[1010818847] 'read index received' (duration: 110.841544ms)","trace[1010818847] 'applied index is now lower than readState.Index' (duration: 91.932µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:14:14.705193Z","caller":"traceutil/trace.go:171","msg":"trace[442024877] transaction","detail":"{read_only:false; response_revision:5603; number_of_response:1; }","duration":"113.582745ms","start":"2026-04-06T21:14:14.591579Z","end":"2026-04-06T21:14:14.705161Z","steps":["trace[442024877] 'process raft request' (duration: 113.306299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:14.705449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.304794ms","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-06T21:14:14.705547Z","caller":"traceutil/trace.go:171","msg":"trace[1417651045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5603; }","duration":"111.440507ms","start":"2026-04-06T21:14:14.594082Z","end":"2026-04-06T21:14:14.705522Z","steps":["trace[1417651045] 'agreement among raft nodes before linearized reading' (duration: 111.11101ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:14.73358Z","caller":"traceutil/trace.go:171","msg":"trace[1415617083] transaction","detail":"{read_only:false; response_revision:5605; number_of_response:1; }","duration":"131.691002ms","start":"2026-04-06T21:14:14.601875Z","end":"2026-04-06T21:14:14.733566Z","steps":["trace[1415617083] 'process raft request' (duration: 131.644391ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:14.733629Z","caller":"traceutil/trace.go:171","msg":"trace[966716310] transaction","detail":"{read_only:false; response_revision:5604; number_of_response:1; }","duration":"138.833861ms","start":"2026-04-06T21:14:14.594742Z","end":"2026-04-06T21:14:14.733576Z","steps":["trace[966716310] 'process raft request' (duration: 138.707188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:14.733918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.326079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-06T21:14:14.734177Z","caller":"traceutil/trace.go:171","msg":"trace[1728917077] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5606; }","duration":"125.677317ms","start":"2026-04-06T21:14:14.608478Z","end":"2026-04-06T21:14:14.734156Z","steps":["trace[1728917077] 'agreement among raft nodes before linearized reading' (duration: 125.272397ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:14:14.734233Z","caller":"traceutil/trace.go:171","msg":"trace[875185027] transaction","detail":"{read_only:false; response_revision:5606; number_of_response:1; }","duration":"130.760141ms","start":"2026-04-06T21:14:14.603193Z","end":"2026-04-06T21:14:14.733953Z","steps":["trace[875185027] 'process raft request' (duration: 130.352771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:14:14.734266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.96491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17207"} {"level":"info","ts":"2026-04-06T21:14:14.734334Z","caller":"traceutil/trace.go:171","msg":"trace[48962439] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5606; }","duration":"112.064522ms","start":"2026-04-06T21:14:14.622255Z","end":"2026-04-06T21:14:14.734319Z","steps":["trace[48962439] 'agreement among raft nodes before linearized reading' (duration: 111.716415ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:15:08.79527Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2991} {"level":"info","ts":"2026-04-06T21:15:08.871554Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2991,"took":"73.922725ms","hash":963181286,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":33632256,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-06T21:15:08.871633Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":963181286,"revision":2991,"compact-revision":-1} {"level":"info","ts":"2026-04-06T21:20:06.489768Z","caller":"traceutil/trace.go:171","msg":"trace[1470121975] transaction","detail":"{read_only:false; response_revision:8257; number_of_response:1; }","duration":"495.426541ms","start":"2026-04-06T21:20:05.994289Z","end":"2026-04-06T21:20:06.489715Z","steps":["trace[1470121975] 'process raft request' (duration: 407.312639ms)","trace[1470121975] 'compare' (duration: 87.979599ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:20:06.489935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:05.994269Z","time spent":"495.582005ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:20:06.596035Z","caller":"traceutil/trace.go:171","msg":"trace[770016490] transaction","detail":"{read_only:false; response_revision:8258; number_of_response:1; }","duration":"601.559888ms","start":"2026-04-06T21:20:05.994409Z","end":"2026-04-06T21:20:06.595969Z","steps":["trace[770016490] 'process raft request' (duration: 600.517305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:06.596251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:05.994368Z","time spent":"601.761082ms","remote":"127.0.0.1:34114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1119,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:20:06.59624Z","caller":"traceutil/trace.go:171","msg":"trace[274278841] transaction","detail":"{read_only:false; response_revision:8259; number_of_response:1; }","duration":"599.374758ms","start":"2026-04-06T21:20:05.996837Z","end":"2026-04-06T21:20:06.596212Z","steps":["trace[274278841] 'process raft request' (duration: 599.076181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:06.596389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:05.996794Z","time spent":"599.524451ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:20:06.596621Z","caller":"traceutil/trace.go:171","msg":"trace[544170302] linearizableReadLoop","detail":"{readStateIndex:8556; appliedIndex:8552; }","duration":"592.711959ms","start":"2026-04-06T21:20:06.003886Z","end":"2026-04-06T21:20:06.596598Z","steps":["trace[544170302] 'read index received' (duration: 397.715594ms)","trace[544170302] 'applied index is now lower than readState.Index' (duration: 194.995444ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:06.596705Z","caller":"traceutil/trace.go:171","msg":"trace[647564552] transaction","detail":"{read_only:false; response_revision:8260; number_of_response:1; }","duration":"599.357058ms","start":"2026-04-06T21:20:05.997336Z","end":"2026-04-06T21:20:06.596693Z","steps":["trace[647564552] 'process raft request' (duration: 598.787425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:06.596777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:05.997311Z","time spent":"599.43434ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:20:06.596848Z","caller":"traceutil/trace.go:171","msg":"trace[2026765143] transaction","detail":"{read_only:false; response_revision:8261; number_of_response:1; }","duration":"185.929482ms","start":"2026-04-06T21:20:06.4109Z","end":"2026-04-06T21:20:06.596829Z","steps":["trace[2026765143] 'process raft request' (duration: 185.623455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:06.597003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.104817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-06T21:20:06.597071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.260171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:06.59708Z","caller":"traceutil/trace.go:171","msg":"trace[882737441] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8261; }","duration":"593.22001ms","start":"2026-04-06T21:20:06.003846Z","end":"2026-04-06T21:20:06.597066Z","steps":["trace[882737441] 'agreement among raft nodes before linearized reading' (duration: 592.950104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:06.597213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:06.003831Z","time spent":"593.368293ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-06T21:20:06.597269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.703746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:06.597328Z","caller":"traceutil/trace.go:171","msg":"trace[1093714540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8261; }","duration":"306.801008ms","start":"2026-04-06T21:20:06.290512Z","end":"2026-04-06T21:20:06.597313Z","steps":["trace[1093714540] 'agreement among raft nodes before linearized reading' (duration: 306.708746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:06.597372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:06.29049Z","time spent":"306.87311ms","remote":"127.0.0.1:34028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-06T21:20:06.597119Z","caller":"traceutil/trace.go:171","msg":"trace[1925795900] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:8261; }","duration":"580.353513ms","start":"2026-04-06T21:20:06.016753Z","end":"2026-04-06T21:20:06.597106Z","steps":["trace[1925795900] 'agreement among raft nodes before linearized reading' (duration: 580.282921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:06.597434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:06.016734Z","time spent":"580.687381ms","remote":"127.0.0.1:34280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-04-06T21:20:08.801229Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6059} {"level":"info","ts":"2026-04-06T21:20:08.901049Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6059,"took":"97.312019ms","hash":1447638138,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":23302144,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-06T21:20:08.901123Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1447638138,"revision":6059,"compact-revision":2991} {"level":"warn","ts":"2026-04-06T21:20:18.43465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.498885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:18.434746Z","caller":"traceutil/trace.go:171","msg":"trace[2137447678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8322; }","duration":"144.650568ms","start":"2026-04-06T21:20:18.290076Z","end":"2026-04-06T21:20:18.434727Z","steps":["trace[2137447678] 'range keys from in-memory index tree' (duration: 144.364083ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:18.807382Z","caller":"traceutil/trace.go:171","msg":"trace[980531442] transaction","detail":"{read_only:false; response_revision:8323; number_of_response:1; }","duration":"280.839158ms","start":"2026-04-06T21:20:18.526519Z","end":"2026-04-06T21:20:18.807358Z","steps":["trace[980531442] 'process raft request' (duration: 280.676284ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:18.812248Z","caller":"traceutil/trace.go:171","msg":"trace[1082222564] transaction","detail":"{read_only:false; response_revision:8324; number_of_response:1; }","duration":"162.541968ms","start":"2026-04-06T21:20:18.649682Z","end":"2026-04-06T21:20:18.812224Z","steps":["trace[1082222564] 'process raft request' (duration: 162.362404ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:18.812484Z","caller":"traceutil/trace.go:171","msg":"trace[1798742874] linearizableReadLoop","detail":"{readStateIndex:8627; appliedIndex:8623; }","duration":"155.778548ms","start":"2026-04-06T21:20:18.656689Z","end":"2026-04-06T21:20:18.812467Z","steps":["trace[1798742874] 'read index received' (duration: 150.436628ms)","trace[1798742874] 'applied index is now lower than readState.Index' (duration: 5.34058ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:18.812486Z","caller":"traceutil/trace.go:171","msg":"trace[1749921145] transaction","detail":"{read_only:false; response_revision:8325; number_of_response:1; }","duration":"161.265671ms","start":"2026-04-06T21:20:18.651197Z","end":"2026-04-06T21:20:18.812463Z","steps":["trace[1749921145] 'process raft request' (duration: 160.985204ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:18.812575Z","caller":"traceutil/trace.go:171","msg":"trace[1331310238] transaction","detail":"{read_only:false; response_revision:8326; number_of_response:1; }","duration":"159.955781ms","start":"2026-04-06T21:20:18.652607Z","end":"2026-04-06T21:20:18.812563Z","steps":["trace[1331310238] 'process raft request' (duration: 159.775467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:18.812695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.982342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-06T21:20:18.812783Z","caller":"traceutil/trace.go:171","msg":"trace[81262616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8326; }","duration":"156.097664ms","start":"2026-04-06T21:20:18.656667Z","end":"2026-04-06T21:20:18.812765Z","steps":["trace[81262616] 'agreement among raft nodes before linearized reading' (duration: 155.88493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:18.812822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.703691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-06T21:20:18.812835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.454857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-06T21:20:18.812831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.784174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-06T21:20:18.812885Z","caller":"traceutil/trace.go:171","msg":"trace[987547198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8326; }","duration":"153.800693ms","start":"2026-04-06T21:20:18.659067Z","end":"2026-04-06T21:20:18.812868Z","steps":["trace[987547198] 'agreement among raft nodes before linearized reading' (duration: 153.618669ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:18.812889Z","caller":"traceutil/trace.go:171","msg":"trace[1788997911] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8326; }","duration":"154.57305ms","start":"2026-04-06T21:20:18.658302Z","end":"2026-04-06T21:20:18.812875Z","steps":["trace[1788997911] 'agreement among raft nodes before linearized reading' (duration: 154.393786ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:18.812909Z","caller":"traceutil/trace.go:171","msg":"trace[1062778418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8326; }","duration":"154.867877ms","start":"2026-04-06T21:20:18.658021Z","end":"2026-04-06T21:20:18.812889Z","steps":["trace[1062778418] 'agreement among raft nodes before linearized reading' (duration: 154.610181ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.261712Z","caller":"traceutil/trace.go:171","msg":"trace[1174143275] linearizableReadLoop","detail":"{readStateIndex:8637; appliedIndex:8634; }","duration":"441.888473ms","start":"2026-04-06T21:20:20.819801Z","end":"2026-04-06T21:20:21.261689Z","steps":["trace[1174143275] 'read index received' (duration: 57.948657ms)","trace[1174143275] 'applied index is now lower than readState.Index' (duration: 383.938826ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:21.262161Z","caller":"traceutil/trace.go:171","msg":"trace[1021879784] transaction","detail":"{read_only:false; response_revision:8334; number_of_response:1; }","duration":"443.048539ms","start":"2026-04-06T21:20:20.819093Z","end":"2026-04-06T21:20:21.262142Z","steps":["trace[1021879784] 'process raft request' (duration: 362.930335ms)","trace[1021879784] 'compare' (duration: 79.416008ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:21.262187Z","caller":"traceutil/trace.go:171","msg":"trace[1244923109] transaction","detail":"{read_only:false; response_revision:8337; number_of_response:1; }","duration":"424.33895ms","start":"2026-04-06T21:20:20.837815Z","end":"2026-04-06T21:20:21.262154Z","steps":["trace[1244923109] 'process raft request' (duration: 423.833319ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.262197Z","caller":"traceutil/trace.go:171","msg":"trace[776815589] transaction","detail":"{read_only:false; response_revision:8335; number_of_response:1; }","duration":"443.023238ms","start":"2026-04-06T21:20:20.81913Z","end":"2026-04-06T21:20:21.262153Z","steps":["trace[776815589] 'process raft request' (duration: 442.430505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.262255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.433316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.262277Z","caller":"traceutil/trace.go:171","msg":"trace[631149020] transaction","detail":"{read_only:false; response_revision:8336; number_of_response:1; }","duration":"442.694391ms","start":"2026-04-06T21:20:20.819312Z","end":"2026-04-06T21:20:21.262006Z","steps":["trace[631149020] 'process raft request' (duration: 442.286192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.262339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.837802Z","time spent":"424.459272ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:20:21.262343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.819108Z","time spent":"443.155261ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:20:21.262313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.819082Z","time spent":"443.12073ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:20:21.262318Z","caller":"traceutil/trace.go:171","msg":"trace[926817769] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8337; }","duration":"442.543107ms","start":"2026-04-06T21:20:20.819759Z","end":"2026-04-06T21:20:21.262302Z","steps":["trace[926817769] 'agreement among raft nodes before linearized reading' (duration: 442.418174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.262468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.81974Z","time spent":"442.715742ms","remote":"127.0.0.1:39476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 "} {"level":"warn","ts":"2026-04-06T21:20:21.262583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.819281Z","time spent":"443.08775ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:20:21.493657Z","caller":"traceutil/trace.go:171","msg":"trace[232063665] linearizableReadLoop","detail":"{readStateIndex:8639; appliedIndex:8638; }","duration":"231.8543ms","start":"2026-04-06T21:20:21.261779Z","end":"2026-04-06T21:20:21.493633Z","steps":["trace[232063665] 'read index received' (duration: 231.698467ms)","trace[232063665] 'applied index is now lower than readState.Index' (duration: 154.803µs)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:20:21.49375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.697711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.493839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.685658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.493891Z","caller":"traceutil/trace.go:171","msg":"trace[503395583] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:8338; }","duration":"496.75627ms","start":"2026-04-06T21:20:20.997119Z","end":"2026-04-06T21:20:21.493875Z","steps":["trace[503395583] 'agreement among raft nodes before linearized reading' (duration: 496.690339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.493901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.565688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.493927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.125648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-06T21:20:21.493923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.87747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.493984Z","caller":"traceutil/trace.go:171","msg":"trace[376050152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8338; }","duration":"664.20957ms","start":"2026-04-06T21:20:20.829761Z","end":"2026-04-06T21:20:21.49397Z","steps":["trace[376050152] 'agreement among raft nodes before linearized reading' (duration: 664.028466ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.494001Z","caller":"traceutil/trace.go:171","msg":"trace[1474767348] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8338; }","duration":"553.989363ms","start":"2026-04-06T21:20:20.939992Z","end":"2026-04-06T21:20:21.493982Z","steps":["trace[1474767348] 'agreement among raft nodes before linearized reading' (duration: 553.85589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.132078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.82975Z","time spent":"664.277981ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-06T21:20:21.494044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.939987Z","time spent":"554.047644ms","remote":"127.0.0.1:59734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:500 "} {"level":"warn","ts":"2026-04-06T21:20:21.494002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.992746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-06T21:20:21.494061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.458499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.164954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.49414Z","caller":"traceutil/trace.go:171","msg":"trace[466668666] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8338; }","duration":"610.148489ms","start":"2026-04-06T21:20:20.883947Z","end":"2026-04-06T21:20:21.494095Z","steps":["trace[466668666] 'agreement among raft nodes before linearized reading' (duration: 609.813892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.061668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.494169Z","caller":"traceutil/trace.go:171","msg":"trace[1113852061] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8338; }","duration":"591.202085ms","start":"2026-04-06T21:20:20.902958Z","end":"2026-04-06T21:20:21.49416Z","steps":["trace[1113852061] 'agreement among raft nodes before linearized reading' (duration: 591.167134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.332526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.878178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.494192Z","caller":"traceutil/trace.go:171","msg":"trace[1479399870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8338; }","duration":"204.12459ms","start":"2026-04-06T21:20:21.290056Z","end":"2026-04-06T21:20:21.494181Z","steps":["trace[1479399870] 'agreement among raft nodes before linearized reading' (duration: 203.959617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.902949Z","time spent":"591.242356ms","remote":"127.0.0.1:59726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "} {"level":"info","ts":"2026-04-06T21:20:21.494217Z","caller":"traceutil/trace.go:171","msg":"trace[60180496] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8338; }","duration":"590.987851ms","start":"2026-04-06T21:20:20.903219Z","end":"2026-04-06T21:20:21.494206Z","steps":["trace[60180496] 'agreement among raft nodes before linearized reading' (duration: 590.867668ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.494238Z","caller":"traceutil/trace.go:171","msg":"trace[2102573548] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8338; }","duration":"628.464749ms","start":"2026-04-06T21:20:20.865744Z","end":"2026-04-06T21:20:21.494208Z","steps":["trace[2102573548] 'agreement among raft nodes before linearized reading' (duration: 628.280895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.49427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.903198Z","time spent":"591.057312ms","remote":"127.0.0.1:59726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 "} {"level":"warn","ts":"2026-04-06T21:20:21.494268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.747077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.871312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.398266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.494168Z","caller":"traceutil/trace.go:171","msg":"trace[1330227948] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8338; }","duration":"628.586591ms","start":"2026-04-06T21:20:20.865556Z","end":"2026-04-06T21:20:21.494142Z","steps":["trace[1330227948] 'agreement among raft nodes before linearized reading' (duration: 628.374367ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.494397Z","caller":"traceutil/trace.go:171","msg":"trace[1276326066] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8338; }","duration":"609.932334ms","start":"2026-04-06T21:20:20.884428Z","end":"2026-04-06T21:20:21.494361Z","steps":["trace[1276326066] 'agreement among raft nodes before linearized reading' (duration: 609.815282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.865737Z","time spent":"628.582171ms","remote":"127.0.0.1:59722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:500 "} {"level":"info","ts":"2026-04-06T21:20:21.493944Z","caller":"traceutil/trace.go:171","msg":"trace[1979173871] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8338; }","duration":"673.641951ms","start":"2026-04-06T21:20:20.820289Z","end":"2026-04-06T21:20:21.493931Z","steps":["trace[1979173871] 'agreement among raft nodes before linearized reading' (duration: 673.549589ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.494446Z","caller":"traceutil/trace.go:171","msg":"trace[293540959] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8338; }","duration":"644.595001ms","start":"2026-04-06T21:20:20.849786Z","end":"2026-04-06T21:20:21.494381Z","steps":["trace[293540959] 'agreement among raft nodes before linearized reading' (duration: 644.307864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.763798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gzzlc\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-04-06T21:20:21.494456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.820282Z","time spent":"674.163252ms","remote":"127.0.0.1:39476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 "} {"level":"warn","ts":"2026-04-06T21:20:21.494451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.88442Z","time spent":"610.017256ms","remote":"127.0.0.1:59724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 "} {"level":"info","ts":"2026-04-06T21:20:21.494486Z","caller":"traceutil/trace.go:171","msg":"trace[1686031319] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gzzlc; range_end:; response_count:1; response_revision:8338; }","duration":"118.83201ms","start":"2026-04-06T21:20:21.375645Z","end":"2026-04-06T21:20:21.494477Z","steps":["trace[1686031319] 'agreement among raft nodes before linearized reading' (duration: 118.730007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.849776Z","time spent":"644.702363ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:10000 "} {"level":"warn","ts":"2026-04-06T21:20:21.494577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.875891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.494607Z","caller":"traceutil/trace.go:171","msg":"trace[7802659] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8338; }","duration":"608.917261ms","start":"2026-04-06T21:20:20.88568Z","end":"2026-04-06T21:20:21.494597Z","steps":["trace[7802659] 'agreement among raft nodes before linearized reading' (duration: 608.881211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.56766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.188881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.193078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.49473Z","caller":"traceutil/trace.go:171","msg":"trace[253613621] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8338; }","duration":"509.25054ms","start":"2026-04-06T21:20:20.985468Z","end":"2026-04-06T21:20:21.494719Z","steps":["trace[253613621] 'agreement among raft nodes before linearized reading' (duration: 509.206539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.493988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.006295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.985451Z","time spent":"509.310281ms","remote":"127.0.0.1:59752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:500 "} {"level":"warn","ts":"2026-04-06T21:20:21.494773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.705562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-06T21:20:21.494696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.699271ms","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-06T21:20:21.494806Z","caller":"traceutil/trace.go:171","msg":"trace[784520381] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8338; }","duration":"610.747163ms","start":"2026-04-06T21:20:20.884047Z","end":"2026-04-06T21:20:21.494794Z","steps":["trace[784520381] 'agreement among raft nodes before linearized reading' (duration: 610.670721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.494072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.640645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.884041Z","time spent":"610.793174ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-06T21:20:21.494841Z","caller":"traceutil/trace.go:171","msg":"trace[1641354897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8338; }","duration":"610.861415ms","start":"2026-04-06T21:20:20.883967Z","end":"2026-04-06T21:20:21.494828Z","steps":["trace[1641354897] 'agreement among raft nodes before linearized reading' (duration: 610.6342ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.494856Z","caller":"traceutil/trace.go:171","msg":"trace[1874647288] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8338; }","duration":"658.566533ms","start":"2026-04-06T21:20:20.836278Z","end":"2026-04-06T21:20:21.494844Z","steps":["trace[1874647288] 'agreement among raft nodes before linearized reading' (duration: 658.506991ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.49487Z","caller":"traceutil/trace.go:171","msg":"trace[1857899185] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8338; }","duration":"592.006853ms","start":"2026-04-06T21:20:20.902853Z","end":"2026-04-06T21:20:21.49486Z","steps":["trace[1857899185] 'agreement among raft nodes before linearized reading' (duration: 591.635075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.883955Z","time spent":"610.912696ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-06T21:20:21.494881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.400039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.836266Z","time spent":"658.622695ms","remote":"127.0.0.1:39482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 "} {"level":"info","ts":"2026-04-06T21:20:21.494918Z","caller":"traceutil/trace.go:171","msg":"trace[500617976] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8338; }","duration":"629.467901ms","start":"2026-04-06T21:20:20.86544Z","end":"2026-04-06T21:20:21.494908Z","steps":["trace[500617976] 'agreement among raft nodes before linearized reading' (duration: 629.40939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.902835Z","time spent":"592.064584ms","remote":"127.0.0.1:59726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 "} {"level":"warn","ts":"2026-04-06T21:20:21.49375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.162987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.865422Z","time spent":"629.531312ms","remote":"127.0.0.1:59722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:10000 "} {"level":"warn","ts":"2026-04-06T21:20:21.493937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.997105Z","time spent":"496.822592ms","remote":"127.0.0.1:49714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-06T21:20:21.494989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.305724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.494997Z","caller":"traceutil/trace.go:171","msg":"trace[800546876] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8338; }","duration":"610.449345ms","start":"2026-04-06T21:20:20.88453Z","end":"2026-04-06T21:20:21.49498Z","steps":["trace[800546876] 'agreement among raft nodes before linearized reading' (duration: 609.129726ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.495022Z","caller":"traceutil/trace.go:171","msg":"trace[1208291150] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8338; }","duration":"510.384746ms","start":"2026-04-06T21:20:20.984629Z","end":"2026-04-06T21:20:21.495014Z","steps":["trace[1208291150] 'agreement among raft nodes before linearized reading' (duration: 510.329004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.495049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.984604Z","time spent":"510.438028ms","remote":"127.0.0.1:59752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true "} {"level":"warn","ts":"2026-04-06T21:20:21.495053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.884522Z","time spent":"610.512096ms","remote":"127.0.0.1:59724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true "} {"level":"info","ts":"2026-04-06T21:20:21.495009Z","caller":"traceutil/trace.go:171","msg":"trace[688533009] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8338; }","duration":"510.377536ms","start":"2026-04-06T21:20:20.984322Z","end":"2026-04-06T21:20:21.4947Z","steps":["trace[688533009] 'agreement among raft nodes before linearized reading' (duration: 509.564338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.494254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.642305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.495205Z","caller":"traceutil/trace.go:171","msg":"trace[1748358110] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8338; }","duration":"533.572896ms","start":"2026-04-06T21:20:20.961594Z","end":"2026-04-06T21:20:21.495167Z","steps":["trace[1748358110] 'agreement among raft nodes before linearized reading' (duration: 532.632484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.495253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.984301Z","time spent":"510.815646ms","remote":"127.0.0.1:59752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:10000 "} {"level":"warn","ts":"2026-04-06T21:20:21.494329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.324089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.495273Z","caller":"traceutil/trace.go:171","msg":"trace[144135422] transaction","detail":"{read_only:false; response_revision:8338; number_of_response:1; }","duration":"495.444112ms","start":"2026-04-06T21:20:20.998362Z","end":"2026-04-06T21:20:21.493806Z","steps":["trace[144135422] 'process raft request' (duration: 495.108314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.495288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.96159Z","time spent":"533.683048ms","remote":"127.0.0.1:59736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:500 "} {"level":"info","ts":"2026-04-06T21:20:21.494392Z","caller":"traceutil/trace.go:171","msg":"trace[553787106] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8338; }","duration":"658.85527ms","start":"2026-04-06T21:20:20.835496Z","end":"2026-04-06T21:20:21.494351Z","steps":["trace[553787106] 'agreement among raft nodes before linearized reading' (duration: 658.736167ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.495309Z","caller":"traceutil/trace.go:171","msg":"trace[1797097831] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8338; }","duration":"639.810503ms","start":"2026-04-06T21:20:20.853995Z","end":"2026-04-06T21:20:21.493805Z","steps":["trace[1797097831] 'agreement among raft nodes before linearized reading' (duration: 639.69045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.495374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.99834Z","time spent":"496.970576ms","remote":"127.0.0.1:34226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19436,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:20:21.494059Z","caller":"traceutil/trace.go:171","msg":"trace[511097498] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8338; }","duration":"555.185008ms","start":"2026-04-06T21:20:20.938866Z","end":"2026-04-06T21:20:21.494051Z","steps":["trace[511097498] 'agreement among raft nodes before linearized reading' (duration: 555.140967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.495416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.835489Z","time spent":"659.895604ms","remote":"127.0.0.1:39482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 "} {"level":"warn","ts":"2026-04-06T21:20:21.494647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.885673Z","time spent":"608.965802ms","remote":"127.0.0.1:59724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 "} {"level":"warn","ts":"2026-04-06T21:20:21.493988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.099572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.883932Z","time spent":"610.245952ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-06T21:20:21.495563Z","caller":"traceutil/trace.go:171","msg":"trace[535405039] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8338; }","duration":"675.685467ms","start":"2026-04-06T21:20:20.819868Z","end":"2026-04-06T21:20:21.495553Z","steps":["trace[535405039] 'agreement among raft nodes before linearized reading' (duration: 674.098461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.495612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.81986Z","time spent":"675.735168ms","remote":"127.0.0.1:39476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true "} {"level":"warn","ts":"2026-04-06T21:20:21.494365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.428131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:20:21.494404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.865544Z","time spent":"628.846918ms","remote":"127.0.0.1:59722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true "} {"level":"warn","ts":"2026-04-06T21:20:21.495521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.938853Z","time spent":"556.595771ms","remote":"127.0.0.1:59734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:10000 "} {"level":"info","ts":"2026-04-06T21:20:21.495674Z","caller":"traceutil/trace.go:171","msg":"trace[15363360] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8338; }","duration":"534.726091ms","start":"2026-04-06T21:20:20.96093Z","end":"2026-04-06T21:20:21.495656Z","steps":["trace[15363360] 'agreement among raft nodes before linearized reading' (duration: 533.417011ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.494796Z","caller":"traceutil/trace.go:171","msg":"trace[285506030] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8338; }","duration":"555.832113ms","start":"2026-04-06T21:20:20.938951Z","end":"2026-04-06T21:20:21.494783Z","steps":["trace[285506030] 'agreement among raft nodes before linearized reading' (duration: 555.010965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.495784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.938933Z","time spent":"556.839066ms","remote":"127.0.0.1:59734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true "} {"level":"info","ts":"2026-04-06T21:20:21.495314Z","caller":"traceutil/trace.go:171","msg":"trace[424211069] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8338; }","duration":"534.328022ms","start":"2026-04-06T21:20:20.960974Z","end":"2026-04-06T21:20:21.495302Z","steps":["trace[424211069] 'agreement among raft nodes before linearized reading' (duration: 533.301608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.495736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.960914Z","time spent":"534.805263ms","remote":"127.0.0.1:59736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true "} {"level":"info","ts":"2026-04-06T21:20:21.494651Z","caller":"traceutil/trace.go:171","msg":"trace[360622950] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8338; }","duration":"644.646181ms","start":"2026-04-06T21:20:20.849994Z","end":"2026-04-06T21:20:21.49464Z","steps":["trace[360622950] 'agreement among raft nodes before linearized reading' (duration: 644.57722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.495839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.960963Z","time spent":"534.862614ms","remote":"127.0.0.1:59736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:10000 "} {"level":"warn","ts":"2026-04-06T21:20:21.496005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.849975Z","time spent":"645.968542ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true "} {"level":"warn","ts":"2026-04-06T21:20:21.496244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.675861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:21.496299Z","caller":"traceutil/trace.go:171","msg":"trace[517823993] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8338; }","duration":"660.762253ms","start":"2026-04-06T21:20:20.835524Z","end":"2026-04-06T21:20:21.496286Z","steps":["trace[517823993] 'agreement among raft nodes before linearized reading' (duration: 660.66411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.496487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.83552Z","time spent":"660.952037ms","remote":"127.0.0.1:39482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true "} {"level":"warn","ts":"2026-04-06T21:20:21.497044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:20.853976Z","time spent":"641.40971ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:500 "} {"level":"info","ts":"2026-04-06T21:20:21.674347Z","caller":"traceutil/trace.go:171","msg":"trace[1347258981] transaction","detail":"{read_only:false; response_revision:8341; number_of_response:1; }","duration":"172.214805ms","start":"2026-04-06T21:20:21.502101Z","end":"2026-04-06T21:20:21.674316Z","steps":["trace[1347258981] 'process raft request' (duration: 172.132693ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:21.674379Z","caller":"traceutil/trace.go:171","msg":"trace[1534162085] transaction","detail":"{read_only:false; response_revision:8340; number_of_response:1; }","duration":"172.294687ms","start":"2026-04-06T21:20:21.502042Z","end":"2026-04-06T21:20:21.674337Z","steps":["trace[1534162085] 'process raft request' (duration: 112.706592ms)","trace[1534162085] 'compare' (duration: 59.345159ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:21.67445Z","caller":"traceutil/trace.go:171","msg":"trace[627756660] linearizableReadLoop","detail":"{readStateIndex:8642; appliedIndex:8639; }","duration":"170.990409ms","start":"2026-04-06T21:20:21.503429Z","end":"2026-04-06T21:20:21.674419Z","steps":["trace[627756660] 'read index received' (duration: 23.65669ms)","trace[627756660] 'applied index is now lower than readState.Index' (duration: 147.327049ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:21.674847Z","caller":"traceutil/trace.go:171","msg":"trace[1984189683] transaction","detail":"{read_only:false; response_revision:8342; number_of_response:1; }","duration":"171.180672ms","start":"2026-04-06T21:20:21.503648Z","end":"2026-04-06T21:20:21.674829Z","steps":["trace[1984189683] 'process raft request' (duration: 170.629599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:21.674889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.445239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224136"} {"level":"info","ts":"2026-04-06T21:20:21.674929Z","caller":"traceutil/trace.go:171","msg":"trace[1566421] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8342; }","duration":"171.541641ms","start":"2026-04-06T21:20:21.503376Z","end":"2026-04-06T21:20:21.674918Z","steps":["trace[1566421] 'agreement among raft nodes before linearized reading' (duration: 171.136122ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:45.45399Z","caller":"traceutil/trace.go:171","msg":"trace[959586843] transaction","detail":"{read_only:false; response_revision:8514; number_of_response:1; }","duration":"111.940916ms","start":"2026-04-06T21:20:45.342011Z","end":"2026-04-06T21:20:45.453952Z","steps":["trace[959586843] 'process raft request' (duration: 111.735051ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:45.454676Z","caller":"traceutil/trace.go:171","msg":"trace[287220677] transaction","detail":"{read_only:false; response_revision:8517; number_of_response:1; }","duration":"103.841965ms","start":"2026-04-06T21:20:45.350819Z","end":"2026-04-06T21:20:45.454661Z","steps":["trace[287220677] 'process raft request' (duration: 103.794524ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:45.454929Z","caller":"traceutil/trace.go:171","msg":"trace[196217081] transaction","detail":"{read_only:false; response_revision:8515; number_of_response:1; }","duration":"112.649761ms","start":"2026-04-06T21:20:45.342263Z","end":"2026-04-06T21:20:45.454913Z","steps":["trace[196217081] 'process raft request' (duration: 112.231922ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:45.455187Z","caller":"traceutil/trace.go:171","msg":"trace[684645626] transaction","detail":"{read_only:false; response_revision:8516; number_of_response:1; }","duration":"112.823506ms","start":"2026-04-06T21:20:45.342333Z","end":"2026-04-06T21:20:45.455157Z","steps":["trace[684645626] 'process raft request' (duration: 112.241053ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:48.46946Z","caller":"traceutil/trace.go:171","msg":"trace[605667931] linearizableReadLoop","detail":"{readStateIndex:8845; appliedIndex:8844; }","duration":"143.371899ms","start":"2026-04-06T21:20:48.326063Z","end":"2026-04-06T21:20:48.469435Z","steps":["trace[605667931] 'read index received' (duration: 143.243667ms)","trace[605667931] 'applied index is now lower than readState.Index' (duration: 127.282µs)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:20:48.469642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.549654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:48.469687Z","caller":"traceutil/trace.go:171","msg":"trace[1346448156] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:8536; }","duration":"143.626516ms","start":"2026-04-06T21:20:48.326049Z","end":"2026-04-06T21:20:48.469675Z","steps":["trace[1346448156] 'agreement among raft nodes before linearized reading' (duration: 143.486813ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:48.470107Z","caller":"traceutil/trace.go:171","msg":"trace[1063654276] transaction","detail":"{read_only:false; response_revision:8536; number_of_response:1; }","duration":"158.669383ms","start":"2026-04-06T21:20:48.311417Z","end":"2026-04-06T21:20:48.470086Z","steps":["trace[1063654276] 'process raft request' (duration: 157.811463ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:52.026225Z","caller":"traceutil/trace.go:171","msg":"trace[2040898303] linearizableReadLoop","detail":"{readStateIndex:8862; appliedIndex:8861; }","duration":"207.438584ms","start":"2026-04-06T21:20:51.818762Z","end":"2026-04-06T21:20:52.026201Z","steps":["trace[2040898303] 'read index received' (duration: 109.580692ms)","trace[2040898303] 'applied index is now lower than readState.Index' (duration: 97.856472ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:52.026339Z","caller":"traceutil/trace.go:171","msg":"trace[859362428] transaction","detail":"{read_only:false; response_revision:8553; number_of_response:1; }","duration":"226.110072ms","start":"2026-04-06T21:20:51.800215Z","end":"2026-04-06T21:20:52.026325Z","steps":["trace[859362428] 'process raft request' (duration: 128.057667ms)","trace[859362428] 'compare' (duration: 97.511833ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:20:52.026474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.70164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-06T21:20:52.026559Z","caller":"traceutil/trace.go:171","msg":"trace[387612006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8553; }","duration":"207.831722ms","start":"2026-04-06T21:20:51.818708Z","end":"2026-04-06T21:20:52.026539Z","steps":["trace[387612006] 'agreement among raft nodes before linearized reading' (duration: 207.639998ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:52.184217Z","caller":"traceutil/trace.go:171","msg":"trace[1242048716] linearizableReadLoop","detail":"{readStateIndex:8863; appliedIndex:8862; }","duration":"157.896965ms","start":"2026-04-06T21:20:52.026291Z","end":"2026-04-06T21:20:52.184188Z","steps":["trace[1242048716] 'read index received' (duration: 153.050636ms)","trace[1242048716] 'applied index is now lower than readState.Index' (duration: 4.844929ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:52.184248Z","caller":"traceutil/trace.go:171","msg":"trace[90439799] transaction","detail":"{read_only:false; response_revision:8554; number_of_response:1; }","duration":"255.303697ms","start":"2026-04-06T21:20:51.928919Z","end":"2026-04-06T21:20:52.184223Z","steps":["trace[90439799] 'process raft request' (duration: 250.408457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:52.184312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.080589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-06T21:20:52.184372Z","caller":"traceutil/trace.go:171","msg":"trace[908558448] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:8554; }","duration":"208.200042ms","start":"2026-04-06T21:20:51.976157Z","end":"2026-04-06T21:20:52.184357Z","steps":["trace[908558448] 'agreement among raft nodes before linearized reading' (duration: 208.037978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:52.184375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.414202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gzzlc\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-04-06T21:20:52.184407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.327932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-06T21:20:52.18444Z","caller":"traceutil/trace.go:171","msg":"trace[2005543612] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8554; }","duration":"333.406734ms","start":"2026-04-06T21:20:51.851026Z","end":"2026-04-06T21:20:52.184433Z","steps":["trace[2005543612] 'agreement among raft nodes before linearized reading' (duration: 333.268461ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:52.18444Z","caller":"traceutil/trace.go:171","msg":"trace[308136575] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gzzlc; range_end:; response_count:1; response_revision:8554; }","duration":"324.534745ms","start":"2026-04-06T21:20:51.859892Z","end":"2026-04-06T21:20:52.184427Z","steps":["trace[308136575] 'agreement among raft nodes before linearized reading' (duration: 324.337841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:52.184469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:51.851006Z","time spent":"333.457705ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-06T21:20:52.184478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:51.859871Z","time spent":"324.600317ms","remote":"127.0.0.1:34240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6551,"request content":"key:\"/registry/pods/openstack/keepalived-gzzlc\" "} {"level":"warn","ts":"2026-04-06T21:20:52.18447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.590843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-06T21:20:52.184522Z","caller":"traceutil/trace.go:171","msg":"trace[1178777707] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8554; }","duration":"343.688094ms","start":"2026-04-06T21:20:51.84082Z","end":"2026-04-06T21:20:52.184508Z","steps":["trace[1178777707] 'agreement among raft nodes before linearized reading' (duration: 343.553031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:52.184551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:51.8408Z","time spent":"343.745566ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-06T21:20:52.19652Z","caller":"traceutil/trace.go:171","msg":"trace[1266221545] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"165.357682ms","start":"2026-04-06T21:20:52.03114Z","end":"2026-04-06T21:20:52.196497Z","steps":["trace[1266221545] 'process raft request' (duration: 165.189718ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:21:01.064438Z","caller":"traceutil/trace.go:171","msg":"trace[992297092] linearizableReadLoop","detail":"{readStateIndex:8956; appliedIndex:8955; }","duration":"182.800262ms","start":"2026-04-06T21:21:00.881605Z","end":"2026-04-06T21:21:01.064406Z","steps":["trace[992297092] 'read index received' (duration: 182.69301ms)","trace[992297092] 'applied index is now lower than readState.Index' (duration: 106.222µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:21:01.064496Z","caller":"traceutil/trace.go:171","msg":"trace[1881686586] transaction","detail":"{read_only:false; response_revision:8642; number_of_response:1; }","duration":"183.229153ms","start":"2026-04-06T21:21:00.881231Z","end":"2026-04-06T21:21:01.06446Z","steps":["trace[1881686586] 'process raft request' (duration: 182.998796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:21:01.064863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.226702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-k8dpz\" ","response":"range_response_count:1 size:4647"} {"level":"info","ts":"2026-04-06T21:21:01.064993Z","caller":"traceutil/trace.go:171","msg":"trace[2073214111] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-k8dpz; range_end:; response_count:1; response_revision:8642; }","duration":"183.410146ms","start":"2026-04-06T21:21:00.88155Z","end":"2026-04-06T21:21:01.06496Z","steps":["trace[2073214111] 'agreement among raft nodes before linearized reading' (duration: 183.000057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:21:01.103647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.797724ms","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-06T21:21:01.103812Z","caller":"traceutil/trace.go:171","msg":"trace[2032276253] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8643; }","duration":"167.04176ms","start":"2026-04-06T21:21:00.936745Z","end":"2026-04-06T21:21:01.103786Z","steps":["trace[2032276253] 'agreement among raft nodes before linearized reading' (duration: 166.775303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:21:01.820739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.908634ms","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-06T21:21:01.820827Z","caller":"traceutil/trace.go:171","msg":"trace[1112165423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8651; }","duration":"107.045778ms","start":"2026-04-06T21:21:01.71376Z","end":"2026-04-06T21:21:01.820806Z","steps":["trace[1112165423] 'range keys from in-memory index tree' (duration: 106.73834ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:21:02.18476Z","caller":"traceutil/trace.go:171","msg":"trace[3771946] transaction","detail":"{read_only:false; response_revision:8654; number_of_response:1; }","duration":"175.157361ms","start":"2026-04-06T21:21:02.009571Z","end":"2026-04-06T21:21:02.184729Z","steps":["trace[3771946] 'process raft request' (duration: 106.75949ms)","trace[3771946] 'compare' (duration: 68.178986ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:21:49.999364Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024b7.wal"} {"level":"info","ts":"2026-04-06T21:22:04.677488Z","caller":"traceutil/trace.go:171","msg":"trace[1877805084] transaction","detail":"{read_only:false; response_revision:9320; number_of_response:1; }","duration":"104.95791ms","start":"2026-04-06T21:22:04.572502Z","end":"2026-04-06T21:22:04.67746Z","steps":["trace[1877805084] 'process raft request' (duration: 104.743376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:22:16.282686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.327159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-04-06T21:22:16.282777Z","caller":"traceutil/trace.go:171","msg":"trace[650637045] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9387; }","duration":"188.925072ms","start":"2026-04-06T21:22:16.09383Z","end":"2026-04-06T21:22:16.282755Z","steps":["trace[650637045] 'range keys from in-memory index tree' (duration: 188.151505ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:22:16.445335Z","caller":"traceutil/trace.go:171","msg":"trace[751690139] transaction","detail":"{read_only:false; response_revision:9388; number_of_response:1; }","duration":"158.780168ms","start":"2026-04-06T21:22:16.286525Z","end":"2026-04-06T21:22:16.445305Z","steps":["trace[751690139] 'process raft request' (duration: 158.605554ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:22:16.463289Z","caller":"traceutil/trace.go:171","msg":"trace[1965132041] linearizableReadLoop","detail":"{readStateIndex:9724; appliedIndex:9722; }","duration":"174.578391ms","start":"2026-04-06T21:22:16.28869Z","end":"2026-04-06T21:22:16.463268Z","steps":["trace[1965132041] 'read index received' (duration: 156.463556ms)","trace[1965132041] 'applied index is now lower than readState.Index' (duration: 18.113895ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:22:16.463405Z","caller":"traceutil/trace.go:171","msg":"trace[1829307687] transaction","detail":"{read_only:false; response_revision:9389; number_of_response:1; }","duration":"176.149587ms","start":"2026-04-06T21:22:16.287205Z","end":"2026-04-06T21:22:16.463354Z","steps":["trace[1829307687] 'process raft request' (duration: 175.958502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:22:16.463489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.845079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-06T21:22:16.463555Z","caller":"traceutil/trace.go:171","msg":"trace[1229118147] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:9389; }","duration":"166.930661ms","start":"2026-04-06T21:22:16.296584Z","end":"2026-04-06T21:22:16.463515Z","steps":["trace[1229118147] 'agreement among raft nodes before linearized reading' (duration: 166.797788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:22:16.463568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.379234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:22:16.46367Z","caller":"traceutil/trace.go:171","msg":"trace[1041402269] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:9389; }","duration":"152.559199ms","start":"2026-04-06T21:22:16.311086Z","end":"2026-04-06T21:22:16.463645Z","steps":["trace[1041402269] 'agreement among raft nodes before linearized reading' (duration: 152.369174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:22:16.463983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.291378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:22:16.46404Z","caller":"traceutil/trace.go:171","msg":"trace[530737733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9389; }","duration":"175.38405ms","start":"2026-04-06T21:22:16.288645Z","end":"2026-04-06T21:22:16.464029Z","steps":["trace[530737733] 'agreement among raft nodes before linearized reading' (duration: 174.735246ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:22:52.63071Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-06T21:22:52.636506Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-06T21:22:52.636642Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-06T21:25:08.808152Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8276} {"level":"info","ts":"2026-04-06T21:25:08.887448Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8276,"took":"77.218577ms","hash":580791938,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":25841664,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-06T21:25:08.887549Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":580791938,"revision":8276,"compact-revision":6059} {"level":"info","ts":"2026-04-06T21:30:08.814793Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10668} {"level":"info","ts":"2026-04-06T21:30:08.892972Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10668,"took":"76.400775ms","hash":595380492,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":21086208,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-06T21:30:08.893024Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":595380492,"revision":10668,"compact-revision":8276}