{"level":"warn","ts":"2026-02-25T02:10:20.919545Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T02:10:20.919667Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.74:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.74:2380","--initial-cluster=instance=https://162.253.55.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.74: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-02-25T02:10:20.919762Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T02:10:20.91978Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-02-25T02:10:20.919805Z","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-02-25T02:10:20.92065Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"]} {"level":"info","ts":"2026-02-25T02:10:20.920749Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.74: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-02-25T02:10:20.925614Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.613413ms"} {"level":"info","ts":"2026-02-25T02:10:20.93725Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30aa8136fb61a722","cluster-id":"e7ea3889c4872560"} {"level":"info","ts":"2026-02-25T02:10:20.93737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T02:10:20.937398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 0"} {"level":"info","ts":"2026-02-25T02:10:20.937427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30aa8136fb61a722 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T02:10:20.937441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 1"} {"level":"info","ts":"2026-02-25T02:10:20.937522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"warn","ts":"2026-02-25T02:10:20.946853Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T02:10:20.948416Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T02:10:20.949778Z","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-02-25T02:10:20.95217Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30aa8136fb61a722","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T02:10:20.952359Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30aa8136fb61a722","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T02:10:20.952466Z","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-02-25T02:10:20.952743Z","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-02-25T02:10:20.952778Z","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-02-25T02:10:20.954155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"info","ts":"2026-02-25T02:10:20.955366Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","added-peer-id":"30aa8136fb61a722","added-peer-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-02-25T02:10:20.95692Z","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-02-25T02:10:20.95707Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-02-25T02:10:20.957194Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-02-25T02:10:20.957485Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30aa8136fb61a722","initial-advertise-peer-urls":["https://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T02:10:20.957525Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T02:10:21.238406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T02:10:21.23847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T02:10:21.238505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgPreVoteResp from 30aa8136fb61a722 at term 1"} {"level":"info","ts":"2026-02-25T02:10:21.238522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became candidate at term 2"} {"level":"info","ts":"2026-02-25T02:10:21.238529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgVoteResp from 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-02-25T02:10:21.23854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became leader at term 2"} {"level":"info","ts":"2026-02-25T02:10:21.23855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30aa8136fb61a722 elected leader 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-02-25T02:10:21.249192Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30aa8136fb61a722","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.74:2379]}","request-path":"/0/members/30aa8136fb61a722/attributes","cluster-id":"e7ea3889c4872560","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T02:10:21.249287Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T02:10:21.24932Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T02:10:21.249393Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:10:21.249801Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T02:10:21.249893Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T02:10:21.251989Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T02:10:21.253311Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.74:2379"} {"level":"info","ts":"2026-02-25T02:10:21.258906Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:10:21.259112Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:10:21.259151Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:10:26.667769Z","caller":"traceutil/trace.go:171","msg":"trace[1013858091] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"102.893122ms","start":"2026-02-25T02:10:26.564842Z","end":"2026-02-25T02:10:26.667735Z","steps":["trace[1013858091] 'process raft request' (duration: 28.671078ms)","trace[1013858091] 'compare' (duration: 73.99033ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:10:31.073636Z","caller":"traceutil/trace.go:171","msg":"trace[1421525129] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:363; }","duration":"109.456381ms","start":"2026-02-25T02:10:30.964152Z","end":"2026-02-25T02:10:31.073608Z","steps":["trace[1421525129] 'read index received' (duration: 81.430364ms)","trace[1421525129] 'applied index is now lower than readState.Index' (duration: 28.024397ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:10:31.073804Z","caller":"traceutil/trace.go:171","msg":"trace[1318616845] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"123.76979ms","start":"2026-02-25T02:10:30.949982Z","end":"2026-02-25T02:10:31.073752Z","steps":["trace[1318616845] 'process raft request' (duration: 95.659811ms)","trace[1318616845] 'compare' (duration: 27.851224ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:10:31.073834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.653695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-25T02:10:31.074174Z","caller":"traceutil/trace.go:171","msg":"trace[976731149] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:352; }","duration":"110.054723ms","start":"2026-02-25T02:10:30.964098Z","end":"2026-02-25T02:10:31.074153Z","steps":["trace[976731149] 'agreement among raft nodes before linearized reading' (duration: 109.663835ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:10:39.111633Z","caller":"traceutil/trace.go:171","msg":"trace[1900331715] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"201.867243ms","start":"2026-02-25T02:10:38.90974Z","end":"2026-02-25T02:10:39.111607Z","steps":["trace[1900331715] 'process raft request' (duration: 201.704661ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:10:39.441337Z","caller":"traceutil/trace.go:171","msg":"trace[1524533080] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"318.253389ms","start":"2026-02-25T02:10:39.123054Z","end":"2026-02-25T02:10:39.441307Z","steps":["trace[1524533080] 'process raft request' (duration: 239.669477ms)","trace[1524533080] 'compare' (duration: 78.46154ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:10:39.442118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:10:39.123025Z","time spent":"318.392153ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:10:39.45069Z","caller":"traceutil/trace.go:171","msg":"trace[1401937363] linearizableReadLoop","detail":"{readStateIndex:459; appliedIndex:457; }","duration":"193.531993ms","start":"2026-02-25T02:10:39.257126Z","end":"2026-02-25T02:10:39.450658Z","steps":["trace[1401937363] 'read index received' (duration: 105.53581ms)","trace[1401937363] 'applied index is now lower than readState.Index' (duration: 87.995113ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:10:39.450804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.655705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:10:39.450845Z","caller":"traceutil/trace.go:171","msg":"trace[417196582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:444; }","duration":"193.712796ms","start":"2026-02-25T02:10:39.25712Z","end":"2026-02-25T02:10:39.450833Z","steps":["trace[417196582] 'agreement among raft nodes before linearized reading' (duration: 193.635255ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:10:39.450885Z","caller":"traceutil/trace.go:171","msg":"trace[1419483595] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"327.460967ms","start":"2026-02-25T02:10:39.123391Z","end":"2026-02-25T02:10:39.450852Z","steps":["trace[1419483595] 'process raft request' (duration: 327.158231ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:10:39.451024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:10:39.123368Z","time spent":"327.581479ms","remote":"127.0.0.1:51770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7021,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:10:40.71885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.606959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:10:40.719049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.32324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T02:10:40.719178Z","caller":"traceutil/trace.go:171","msg":"trace[926500314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:449; }","duration":"282.498404ms","start":"2026-02-25T02:10:40.436652Z","end":"2026-02-25T02:10:40.719151Z","steps":["trace[926500314] 'range keys from in-memory index tree' (duration: 282.163157ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:10:40.719084Z","caller":"traceutil/trace.go:171","msg":"trace[1704569446] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:449; }","duration":"464.903425ms","start":"2026-02-25T02:10:40.254155Z","end":"2026-02-25T02:10:40.719058Z","steps":["trace[1704569446] 'range keys from in-memory index tree' (duration: 464.473457ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:10:40.719347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:10:40.254128Z","time spent":"465.176299ms","remote":"127.0.0.1:51638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T02:10:52.576174Z","caller":"traceutil/trace.go:171","msg":"trace[1940904497] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"124.648357ms","start":"2026-02-25T02:10:52.451502Z","end":"2026-02-25T02:10:52.57615Z","steps":["trace[1940904497] 'process raft request' (duration: 124.439662ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:10:53.008023Z","caller":"traceutil/trace.go:171","msg":"trace[1479773709] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:559; }","duration":"127.852674ms","start":"2026-02-25T02:10:52.880147Z","end":"2026-02-25T02:10:53.008Z","steps":["trace[1479773709] 'read index received' (duration: 127.682291ms)","trace[1479773709] 'applied index is now lower than readState.Index' (duration: 168.782µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:10:53.008256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.078738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-25T02:10:53.008287Z","caller":"traceutil/trace.go:171","msg":"trace[477177852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:542; }","duration":"128.191319ms","start":"2026-02-25T02:10:52.880087Z","end":"2026-02-25T02:10:53.008278Z","steps":["trace[477177852] 'agreement among raft nodes before linearized reading' (duration: 128.007956ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:10:53.008543Z","caller":"traceutil/trace.go:171","msg":"trace[1682587856] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"172.39448ms","start":"2026-02-25T02:10:52.836114Z","end":"2026-02-25T02:10:53.008508Z","steps":["trace[1682587856] 'process raft request' (duration: 171.748709ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:10:59.649704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.272423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:10:59.649845Z","caller":"traceutil/trace.go:171","msg":"trace[656122928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"391.456336ms","start":"2026-02-25T02:10:59.258337Z","end":"2026-02-25T02:10:59.649794Z","steps":["trace[656122928] 'range keys from in-memory index tree' (duration: 391.176051ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:10:59.649902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:10:59.258308Z","time spent":"391.578288ms","remote":"127.0.0.1:51638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T02:10:59.649925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.877043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rgzk5\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-25T02:10:59.650051Z","caller":"traceutil/trace.go:171","msg":"trace[1727916890] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rgzk5; range_end:; response_count:1; response_revision:603; }","duration":"187.040156ms","start":"2026-02-25T02:10:59.462969Z","end":"2026-02-25T02:10:59.650009Z","steps":["trace[1727916890] 'range keys from in-memory index tree' (duration: 186.578818ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:10:59.924745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.152252ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-25T02:10:59.924875Z","caller":"traceutil/trace.go:171","msg":"trace[1545237438] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"381.519205ms","start":"2026-02-25T02:10:59.54333Z","end":"2026-02-25T02:10:59.924849Z","steps":["trace[1545237438] 'read index received' (duration: 102.068808ms)","trace[1545237438] 'applied index is now lower than readState.Index' (duration: 279.448697ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:10:59.92507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.726308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T02:10:59.925145Z","caller":"traceutil/trace.go:171","msg":"trace[1937345318] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"381.856571ms","start":"2026-02-25T02:10:59.543271Z","end":"2026-02-25T02:10:59.925127Z","steps":["trace[1937345318] 'agreement among raft nodes before linearized reading' (duration: 381.636697ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:10:59.925203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:10:59.543248Z","time spent":"381.941682ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T02:11:00.001191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.333671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:11:00.001231Z","caller":"traceutil/trace.go:171","msg":"trace[115142503] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"335.873889ms","start":"2026-02-25T02:10:59.665319Z","end":"2026-02-25T02:11:00.001193Z","steps":["trace[115142503] 'process raft request' (duration: 335.646585ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:11:00.001281Z","caller":"traceutil/trace.go:171","msg":"trace[1161809896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"350.460434ms","start":"2026-02-25T02:10:59.650805Z","end":"2026-02-25T02:11:00.001266Z","steps":["trace[1161809896] 'agreement among raft nodes before linearized reading' (duration: 350.308591ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:00.001313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:10:59.650791Z","time spent":"350.515935ms","remote":"127.0.0.1:51624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T02:11:00.001356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:10:59.665301Z","time spent":"335.989982ms","remote":"127.0.0.1:51770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:11:00.001396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.172877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-25T02:11:00.001527Z","caller":"traceutil/trace.go:171","msg":"trace[121531895] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:604; }","duration":"340.345821ms","start":"2026-02-25T02:10:59.661164Z","end":"2026-02-25T02:11:00.00151Z","steps":["trace[121531895] 'agreement among raft nodes before linearized reading' (duration: 340.035635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:00.001842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:10:59.661151Z","time spent":"340.444072ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-25T02:11:01.247241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.855536ms","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-02-25T02:11:01.24743Z","caller":"traceutil/trace.go:171","msg":"trace[802118408] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:608; }","duration":"553.08051ms","start":"2026-02-25T02:11:00.694325Z","end":"2026-02-25T02:11:01.247405Z","steps":["trace[802118408] 'range keys from in-memory index tree' (duration: 552.826986ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:01.247566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.037237ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-25T02:11:01.247666Z","caller":"traceutil/trace.go:171","msg":"trace[1444496462] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"668.289235ms","start":"2026-02-25T02:11:00.579359Z","end":"2026-02-25T02:11:01.247648Z","steps":["trace[1444496462] 'process raft request' (duration: 71.068625ms)","trace[1444496462] 'compare' (duration: 596.739212ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:11:01.247833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.579329Z","time spent":"668.383818ms","remote":"127.0.0.1:51794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T02:11:01.365205Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043360506833178189,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T02:11:02.296427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.965558ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-25T02:11:02.296573Z","caller":"traceutil/trace.go:171","msg":"trace[1718914437] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"1.717113009s","start":"2026-02-25T02:11:00.57944Z","end":"2026-02-25T02:11:02.296553Z","steps":["trace[1718914437] 'process raft request' (duration: 1.036941298s)","trace[1718914437] 'compare' (duration: 678.41594ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:11:02.296632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.579418Z","time spent":"1.71719039s","remote":"127.0.0.1:51690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1733,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T02:11:02.332604Z","caller":"traceutil/trace.go:171","msg":"trace[44682126] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:629; }","duration":"1.468219735s","start":"2026-02-25T02:11:00.864358Z","end":"2026-02-25T02:11:02.332578Z","steps":["trace[44682126] 'read index received' (duration: 752.094472ms)","trace[44682126] 'applied index is now lower than readState.Index' (duration: 716.124033ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:11:02.332688Z","caller":"traceutil/trace.go:171","msg":"trace[1408767156] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.674085301s","start":"2026-02-25T02:11:00.658576Z","end":"2026-02-25T02:11:02.332661Z","steps":["trace[1408767156] 'process raft request' (duration: 1.673807376s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.332817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.468351077s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:11:02.332875Z","caller":"traceutil/trace.go:171","msg":"trace[1607497387] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:611; }","duration":"1.468448989s","start":"2026-02-25T02:11:00.864413Z","end":"2026-02-25T02:11:02.332862Z","steps":["trace[1607497387] 'agreement among raft nodes before linearized reading' (duration: 1.468326107s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.332917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.864406Z","time spent":"1.468499779s","remote":"127.0.0.1:44928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-02-25T02:11:02.332989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.909977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T02:11:02.333078Z","caller":"traceutil/trace.go:171","msg":"trace[186707839] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"316.057601ms","start":"2026-02-25T02:11:02.016996Z","end":"2026-02-25T02:11:02.333054Z","steps":["trace[186707839] 'agreement among raft nodes before linearized reading' (duration: 315.762616ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.332971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.468478869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:11:02.33317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.454097648s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:11:02.333195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.312992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-25T02:11:02.333216Z","caller":"traceutil/trace.go:171","msg":"trace[2660241] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:611; }","duration":"270.373964ms","start":"2026-02-25T02:11:02.062836Z","end":"2026-02-25T02:11:02.33321Z","steps":["trace[2660241] 'agreement among raft nodes before linearized reading' (duration: 270.312943ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.333116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:02.016971Z","time spent":"316.138432ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T02:11:02.333275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.420653823s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:11:02.333199Z","caller":"traceutil/trace.go:171","msg":"trace[6935124] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:611; }","duration":"1.468826296s","start":"2026-02-25T02:11:00.864315Z","end":"2026-02-25T02:11:02.333141Z","steps":["trace[6935124] 'agreement among raft nodes before linearized reading' (duration: 1.468367408s)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:11:02.333214Z","caller":"traceutil/trace.go:171","msg":"trace[1749330911] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:611; }","duration":"1.45416329s","start":"2026-02-25T02:11:00.87904Z","end":"2026-02-25T02:11:02.333203Z","steps":["trace[1749330911] 'agreement among raft nodes before linearized reading' (duration: 1.454101238s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.334196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.469230523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:11:02.337449Z","caller":"traceutil/trace.go:171","msg":"trace[1933197543] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:611; }","duration":"1.472543252s","start":"2026-02-25T02:11:00.86489Z","end":"2026-02-25T02:11:02.337433Z","steps":["trace[1933197543] 'agreement among raft nodes before linearized reading' (duration: 1.468289875s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.33422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.202945453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-25T02:11:02.337485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.864873Z","time spent":"1.472600093s","remote":"127.0.0.1:44928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"warn","ts":"2026-02-25T02:11:02.334109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077318339s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:11:02.337649Z","caller":"traceutil/trace.go:171","msg":"trace[1374774546] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:611; }","duration":"1.425030242s","start":"2026-02-25T02:11:00.912585Z","end":"2026-02-25T02:11:02.337615Z","steps":["trace[1374774546] 'agreement among raft nodes before linearized reading' (duration: 1.420667023s)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:11:02.337643Z","caller":"traceutil/trace.go:171","msg":"trace[829263616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:611; }","duration":"1.206286762s","start":"2026-02-25T02:11:01.13123Z","end":"2026-02-25T02:11:02.337516Z","steps":["trace[829263616] 'agreement among raft nodes before linearized reading' (duration: 1.202036956s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.337846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.912567Z","time spent":"1.425251866s","remote":"127.0.0.1:44954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-02-25T02:11:02.337697Z","caller":"traceutil/trace.go:171","msg":"trace[1768573425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"1.080944535s","start":"2026-02-25T02:11:01.256732Z","end":"2026-02-25T02:11:02.337677Z","steps":["trace[1768573425] 'agreement among raft nodes before linearized reading' (duration: 1.076163198s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.334293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.420373348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:11:02.337962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:01.256707Z","time spent":"1.081239191s","remote":"127.0.0.1:51638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T02:11:02.337973Z","caller":"traceutil/trace.go:171","msg":"trace[625806949] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:611; }","duration":"1.425082634s","start":"2026-02-25T02:11:00.91287Z","end":"2026-02-25T02:11:02.337953Z","steps":["trace[625806949] 'agreement among raft nodes before linearized reading' (duration: 1.420368428s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.338001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:01.131211Z","time spent":"1.206754092s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T02:11:02.338117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.912858Z","time spent":"1.425232646s","remote":"127.0.0.1:44954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 "} {"level":"warn","ts":"2026-02-25T02:11:02.334288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.42047095s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:11:02.332834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.658546Z","time spent":"1.674211903s","remote":"127.0.0.1:51686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":211460,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T02:11:02.338205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.86429Z","time spent":"1.473893957s","remote":"127.0.0.1:44928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"info","ts":"2026-02-25T02:11:02.338222Z","caller":"traceutil/trace.go:171","msg":"trace[665194999] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:611; }","duration":"1.425595293s","start":"2026-02-25T02:11:00.912606Z","end":"2026-02-25T02:11:02.338202Z","steps":["trace[665194999] 'agreement among raft nodes before linearized reading' (duration: 1.42044136s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.334358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.43542462s","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":"warn","ts":"2026-02-25T02:11:02.338381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.912591Z","time spent":"1.425716845s","remote":"127.0.0.1:44954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 "} {"level":"info","ts":"2026-02-25T02:11:02.338392Z","caller":"traceutil/trace.go:171","msg":"trace[1006321710] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:611; }","duration":"1.439454774s","start":"2026-02-25T02:11:00.898892Z","end":"2026-02-25T02:11:02.338346Z","steps":["trace[1006321710] 'agreement among raft nodes before linearized reading' (duration: 1.434047496s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.338478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.898876Z","time spent":"1.439563615s","remote":"127.0.0.1:44940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-25T02:11:02.33856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.879025Z","time spent":"1.459512446s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T02:11:02.334405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.435075815s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:11:02.340535Z","caller":"traceutil/trace.go:171","msg":"trace[331186115] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:611; }","duration":"1.441234106s","start":"2026-02-25T02:11:00.899256Z","end":"2026-02-25T02:11:02.340491Z","steps":["trace[331186115] 'agreement among raft nodes before linearized reading' (duration: 1.435053534s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.340587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.899235Z","time spent":"1.441338778s","remote":"127.0.0.1:44940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "} {"level":"warn","ts":"2026-02-25T02:11:02.334458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.45530993s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:11:02.340716Z","caller":"traceutil/trace.go:171","msg":"trace[1482491817] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:611; }","duration":"1.461583514s","start":"2026-02-25T02:11:00.879121Z","end":"2026-02-25T02:11:02.340705Z","steps":["trace[1482491817] 'agreement among raft nodes before linearized reading' (duration: 1.453855774s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.340773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.879085Z","time spent":"1.461676296s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-02-25T02:11:02.334621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.454664369s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:11:02.334566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.435658785s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:11:02.340979Z","caller":"traceutil/trace.go:171","msg":"trace[194252696] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:611; }","duration":"1.461037825s","start":"2026-02-25T02:11:00.879908Z","end":"2026-02-25T02:11:02.340946Z","steps":["trace[194252696] 'agreement among raft nodes before linearized reading' (duration: 1.454449786s)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:11:02.341011Z","caller":"traceutil/trace.go:171","msg":"trace[299666316] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:611; }","duration":"1.442143722s","start":"2026-02-25T02:11:00.898857Z","end":"2026-02-25T02:11:02.341Z","steps":["trace[299666316] 'agreement among raft nodes before linearized reading' (duration: 1.435471891s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.34105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.898841Z","time spent":"1.442196433s","remote":"127.0.0.1:44940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T02:11:02.341045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:00.879899Z","time spent":"1.461121486s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "} {"level":"warn","ts":"2026-02-25T02:11:02.33464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.204368899s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-25T02:11:02.341186Z","caller":"traceutil/trace.go:171","msg":"trace[1612822153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:611; }","duration":"1.211005619s","start":"2026-02-25T02:11:01.130172Z","end":"2026-02-25T02:11:02.341178Z","steps":["trace[1612822153] 'agreement among raft nodes before linearized reading' (duration: 1.203129166s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:02.341207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:11:01.130148Z","time spent":"1.211051399s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T02:11:58.950372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.407069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T02:11:58.95062Z","caller":"traceutil/trace.go:171","msg":"trace[1508665682] linearizableReadLoop","detail":"{readStateIndex:1460; appliedIndex:1458; }","duration":"230.295647ms","start":"2026-02-25T02:11:58.720297Z","end":"2026-02-25T02:11:58.950593Z","steps":["trace[1508665682] 'read index received' (duration: 98.459991ms)","trace[1508665682] 'applied index is now lower than readState.Index' (duration: 131.834586ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:11:58.95071Z","caller":"traceutil/trace.go:171","msg":"trace[1111248182] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"246.451631ms","start":"2026-02-25T02:11:58.704232Z","end":"2026-02-25T02:11:58.950683Z","steps":["trace[1111248182] 'process raft request' (duration: 246.276727ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:11:58.950711Z","caller":"traceutil/trace.go:171","msg":"trace[1246974442] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"249.785642ms","start":"2026-02-25T02:11:58.70088Z","end":"2026-02-25T02:11:58.950666Z","steps":["trace[1246974442] 'process raft request' (duration: 117.942364ms)","trace[1246974442] 'compare' (duration: 131.258266ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:11:58.950921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.0748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-25T02:11:58.950971Z","caller":"traceutil/trace.go:171","msg":"trace[1296584355] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1404; }","duration":"227.148121ms","start":"2026-02-25T02:11:58.723809Z","end":"2026-02-25T02:11:58.950957Z","steps":["trace[1296584355] 'agreement among raft nodes before linearized reading' (duration: 226.910167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:58.95095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.642185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T02:11:58.951032Z","caller":"traceutil/trace.go:171","msg":"trace[817811586] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1404; }","duration":"230.765197ms","start":"2026-02-25T02:11:58.720253Z","end":"2026-02-25T02:11:58.951018Z","steps":["trace[817811586] 'agreement among raft nodes before linearized reading' (duration: 230.427741ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:11:58.951067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.514921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-25T02:11:58.951146Z","caller":"traceutil/trace.go:171","msg":"trace[309634350] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1404; }","duration":"141.633014ms","start":"2026-02-25T02:11:58.809494Z","end":"2026-02-25T02:11:58.951127Z","steps":["trace[309634350] 'agreement among raft nodes before linearized reading' (duration: 141.312298ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:11:59.223821Z","caller":"traceutil/trace.go:171","msg":"trace[159585094] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"146.036684ms","start":"2026-02-25T02:11:59.07775Z","end":"2026-02-25T02:11:59.223787Z","steps":["trace[159585094] 'process raft request' (duration: 145.904862ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:11:59.55074Z","caller":"traceutil/trace.go:171","msg":"trace[2129395845] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"144.347597ms","start":"2026-02-25T02:11:59.40637Z","end":"2026-02-25T02:11:59.550717Z","steps":["trace[2129395845] 'process raft request' (duration: 144.215835ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:00.932971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.364078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:00.933084Z","caller":"traceutil/trace.go:171","msg":"trace[1726942340] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:1440; }","duration":"222.517432ms","start":"2026-02-25T02:12:00.710541Z","end":"2026-02-25T02:12:00.933058Z","steps":["trace[1726942340] 'range keys from in-memory index tree' (duration: 222.305147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:00.9334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.634034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:00.933433Z","caller":"traceutil/trace.go:171","msg":"trace[644018748] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:1440; }","duration":"222.730065ms","start":"2026-02-25T02:12:00.710694Z","end":"2026-02-25T02:12:00.933424Z","steps":["trace[644018748] 'count revisions from in-memory index tree' (duration: 222.526361ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:00.933534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.097694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:00.933561Z","caller":"traceutil/trace.go:171","msg":"trace[225970545] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:1440; }","duration":"222.159155ms","start":"2026-02-25T02:12:00.711395Z","end":"2026-02-25T02:12:00.933554Z","steps":["trace[225970545] 'range keys from in-memory index tree' (duration: 222.029953ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:00.93391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.233133ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T02:12:00.933969Z","caller":"traceutil/trace.go:171","msg":"trace[165930554] linearizableReadLoop","detail":"{readStateIndex:1500; appliedIndex:1499; }","duration":"204.164035ms","start":"2026-02-25T02:12:00.729795Z","end":"2026-02-25T02:12:00.93396Z","steps":["trace[165930554] 'read index received' (duration: 100.818549ms)","trace[165930554] 'applied index is now lower than readState.Index' (duration: 103.344536ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:12:00.934186Z","caller":"traceutil/trace.go:171","msg":"trace[558870690] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"219.572227ms","start":"2026-02-25T02:12:00.714604Z","end":"2026-02-25T02:12:00.934176Z","steps":["trace[558870690] 'process raft request' (duration: 116.001998ms)","trace[558870690] 'compare' (duration: 102.192464ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:12:00.934351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.560481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:00.93438Z","caller":"traceutil/trace.go:171","msg":"trace[676074235] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:1441; }","duration":"204.636643ms","start":"2026-02-25T02:12:00.729736Z","end":"2026-02-25T02:12:00.934373Z","steps":["trace[676074235] 'agreement among raft nodes before linearized reading' (duration: 204.585172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:00.934499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.710854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:00.934527Z","caller":"traceutil/trace.go:171","msg":"trace[1776134167] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:1441; }","duration":"204.782485ms","start":"2026-02-25T02:12:00.729736Z","end":"2026-02-25T02:12:00.934519Z","steps":["trace[1776134167] 'agreement among raft nodes before linearized reading' (duration: 204.743595ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:00.945402Z","caller":"traceutil/trace.go:171","msg":"trace[982566330] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"143.833748ms","start":"2026-02-25T02:12:00.801553Z","end":"2026-02-25T02:12:00.945387Z","steps":["trace[982566330] 'process raft request' (duration: 143.790797ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:00.945685Z","caller":"traceutil/trace.go:171","msg":"trace[1889041250] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"200.968236ms","start":"2026-02-25T02:12:00.744675Z","end":"2026-02-25T02:12:00.945644Z","steps":["trace[1889041250] 'process raft request' (duration: 200.62626ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:00.945785Z","caller":"traceutil/trace.go:171","msg":"trace[496796254] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"201.114268ms","start":"2026-02-25T02:12:00.744661Z","end":"2026-02-25T02:12:00.945775Z","steps":["trace[496796254] 'process raft request' (duration: 200.557368ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.008634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.396483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.008697Z","caller":"traceutil/trace.go:171","msg":"trace[1857049618] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:1445; }","duration":"105.504385ms","start":"2026-02-25T02:12:00.903178Z","end":"2026-02-25T02:12:01.008682Z","steps":["trace[1857049618] 'agreement among raft nodes before linearized reading' (duration: 105.392253ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.008689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.16941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.008829Z","caller":"traceutil/trace.go:171","msg":"trace[1406192882] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:1445; }","duration":"237.354964ms","start":"2026-02-25T02:12:00.771451Z","end":"2026-02-25T02:12:01.008806Z","steps":["trace[1406192882] 'agreement among raft nodes before linearized reading' (duration: 237.20165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.135717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:12:01.008696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.648395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.009477Z","caller":"traceutil/trace.go:171","msg":"trace[1922512391] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:1445; }","duration":"106.220728ms","start":"2026-02-25T02:12:00.903228Z","end":"2026-02-25T02:12:01.009448Z","steps":["trace[1922512391] 'agreement among raft nodes before linearized reading' (duration: 106.138897ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:01.009499Z","caller":"traceutil/trace.go:171","msg":"trace[1724761356] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:1445; }","duration":"162.496711ms","start":"2026-02-25T02:12:00.846975Z","end":"2026-02-25T02:12:01.009472Z","steps":["trace[1724761356] 'agreement among raft nodes before linearized reading' (duration: 161.562653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.008833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.56982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:12:01.008924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.978556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.009636Z","caller":"traceutil/trace.go:171","msg":"trace[38810458] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1445; }","duration":"147.725988ms","start":"2026-02-25T02:12:00.861894Z","end":"2026-02-25T02:12:01.00962Z","steps":["trace[38810458] 'agreement among raft nodes before linearized reading' (duration: 146.977865ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.008985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.772981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.00974Z","caller":"traceutil/trace.go:171","msg":"trace[1729818915] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1445; }","duration":"148.572454ms","start":"2026-02-25T02:12:00.861161Z","end":"2026-02-25T02:12:01.009734Z","steps":["trace[1729818915] 'agreement among raft nodes before linearized reading' (duration: 147.792461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.635278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.009816Z","caller":"traceutil/trace.go:171","msg":"trace[1131460028] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:1445; }","duration":"239.470923ms","start":"2026-02-25T02:12:00.77034Z","end":"2026-02-25T02:12:01.009811Z","steps":["trace[1131460028] 'agreement among raft nodes before linearized reading' (duration: 238.642498ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.517063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.0099Z","caller":"traceutil/trace.go:171","msg":"trace[1132942501] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:1445; }","duration":"258.438329ms","start":"2026-02-25T02:12:00.751456Z","end":"2026-02-25T02:12:01.009894Z","steps":["trace[1132942501] 'agreement among raft nodes before linearized reading' (duration: 257.474522ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.008997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.967696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.009983Z","caller":"traceutil/trace.go:171","msg":"trace[1308918616] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1445; }","duration":"148.006034ms","start":"2026-02-25T02:12:00.861971Z","end":"2026-02-25T02:12:01.009977Z","steps":["trace[1308918616] 'agreement among raft nodes before linearized reading' (duration: 146.850303ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.570896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.010077Z","caller":"traceutil/trace.go:171","msg":"trace[704310291] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:1445; }","duration":"239.717786ms","start":"2026-02-25T02:12:00.770352Z","end":"2026-02-25T02:12:01.01007Z","steps":["trace[704310291] 'agreement among raft nodes before linearized reading' (duration: 238.513165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.0091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.294492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.010171Z","caller":"traceutil/trace.go:171","msg":"trace[407567331] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1445; }","duration":"220.367681ms","start":"2026-02-25T02:12:00.789797Z","end":"2026-02-25T02:12:01.010165Z","steps":["trace[407567331] 'agreement among raft nodes before linearized reading' (duration: 219.279172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.386585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.01038Z","caller":"traceutil/trace.go:171","msg":"trace[1569592141] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:1445; }","duration":"123.71982ms","start":"2026-02-25T02:12:00.886652Z","end":"2026-02-25T02:12:01.010371Z","steps":["trace[1569592141] 'agreement among raft nodes before linearized reading' (duration: 122.427636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.165124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.010466Z","caller":"traceutil/trace.go:171","msg":"trace[1232319692] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:1445; }","duration":"163.513029ms","start":"2026-02-25T02:12:00.846939Z","end":"2026-02-25T02:12:01.010452Z","steps":["trace[1232319692] 'agreement among raft nodes before linearized reading' (duration: 162.148454ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.410306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.010604Z","caller":"traceutil/trace.go:171","msg":"trace[1155659904] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:1445; }","duration":"279.862144ms","start":"2026-02-25T02:12:00.730733Z","end":"2026-02-25T02:12:01.010595Z","steps":["trace[1155659904] 'agreement among raft nodes before linearized reading' (duration: 278.413167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.970325ms","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-02-25T02:12:01.010697Z","caller":"traceutil/trace.go:171","msg":"trace[279689237] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1445; }","duration":"221.446141ms","start":"2026-02-25T02:12:00.789244Z","end":"2026-02-25T02:12:01.01069Z","steps":["trace[279689237] 'agreement among raft nodes before linearized reading' (duration: 219.971954ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.958502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-975cd4d96-fjts7\" ","response":"range_response_count:1 size:5439"} {"level":"info","ts":"2026-02-25T02:12:01.010787Z","caller":"traceutil/trace.go:171","msg":"trace[255866486] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-975cd4d96-fjts7; range_end:; response_count:1; response_revision:1445; }","duration":"210.493571ms","start":"2026-02-25T02:12:00.800283Z","end":"2026-02-25T02:12:01.010777Z","steps":["trace[255866486] 'agreement among raft nodes before linearized reading' (duration: 208.837231ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.628948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.010886Z","caller":"traceutil/trace.go:171","msg":"trace[1178252968] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:1445; }","duration":"107.231468ms","start":"2026-02-25T02:12:00.903648Z","end":"2026-02-25T02:12:01.010879Z","steps":["trace[1178252968] 'agreement among raft nodes before linearized reading' (duration: 105.626368ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.008614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.613404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.010971Z","caller":"traceutil/trace.go:171","msg":"trace[1088290737] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:1445; }","duration":"164.001698ms","start":"2026-02-25T02:12:00.846959Z","end":"2026-02-25T02:12:01.010961Z","steps":["trace[1088290737] 'agreement among raft nodes before linearized reading' (duration: 161.565453ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.009276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.192109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.011113Z","caller":"traceutil/trace.go:171","msg":"trace[1321237232] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1445; }","duration":"222.059313ms","start":"2026-02-25T02:12:00.789043Z","end":"2026-02-25T02:12:01.011103Z","steps":["trace[1321237232] 'agreement among raft nodes before linearized reading' (duration: 220.186789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.008899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.922617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.014436Z","caller":"traceutil/trace.go:171","msg":"trace[681099323] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:1445; }","duration":"260.507348ms","start":"2026-02-25T02:12:00.753894Z","end":"2026-02-25T02:12:01.014401Z","steps":["trace[681099323] 'agreement among raft nodes before linearized reading' (duration: 254.849944ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:01.014516Z","caller":"traceutil/trace.go:171","msg":"trace[1644289062] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:1445; }","duration":"127.257814ms","start":"2026-02-25T02:12:00.887229Z","end":"2026-02-25T02:12:01.014487Z","steps":["trace[1644289062] 'agreement among raft nodes before linearized reading' (duration: 121.554739ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.008986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.631016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.014623Z","caller":"traceutil/trace.go:171","msg":"trace[1494590991] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:1445; }","duration":"263.285229ms","start":"2026-02-25T02:12:00.751308Z","end":"2026-02-25T02:12:01.014593Z","steps":["trace[1494590991] 'agreement among raft nodes before linearized reading' (duration: 257.593225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:01.014661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.11418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:01.014779Z","caller":"traceutil/trace.go:171","msg":"trace[2120760082] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:1445; }","duration":"128.279163ms","start":"2026-02-25T02:12:00.886465Z","end":"2026-02-25T02:12:01.014745Z","steps":["trace[2120760082] 'agreement among raft nodes before linearized reading' (duration: 122.66797ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:02.075945Z","caller":"traceutil/trace.go:171","msg":"trace[140216776] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"241.263216ms","start":"2026-02-25T02:12:01.83466Z","end":"2026-02-25T02:12:02.075923Z","steps":["trace[140216776] 'process raft request' (duration: 241.210935ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:02.076343Z","caller":"traceutil/trace.go:171","msg":"trace[1441203387] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"257.842589ms","start":"2026-02-25T02:12:01.818467Z","end":"2026-02-25T02:12:02.076309Z","steps":["trace[1441203387] 'process raft request' (duration: 171.075167ms)","trace[1441203387] 'compare' (duration: 86.192342ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:12:02.195753Z","caller":"traceutil/trace.go:171","msg":"trace[503798031] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"111.586156ms","start":"2026-02-25T02:12:02.08414Z","end":"2026-02-25T02:12:02.195726Z","steps":["trace[503798031] 'process raft request' (duration: 103.967637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:04.190375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.169584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/pxc-operator\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-02-25T02:12:04.190468Z","caller":"traceutil/trace.go:171","msg":"trace[992502649] range","detail":"{range_begin:/registry/serviceaccounts/openstack/pxc-operator; range_end:; response_count:1; response_revision:1483; }","duration":"126.320357ms","start":"2026-02-25T02:12:04.064129Z","end":"2026-02-25T02:12:04.190449Z","steps":["trace[992502649] 'range keys from in-memory index tree' (duration: 125.96401ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:26.425682Z","caller":"traceutil/trace.go:171","msg":"trace[186494756] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"561.819646ms","start":"2026-02-25T02:12:25.863829Z","end":"2026-02-25T02:12:26.425649Z","steps":["trace[186494756] 'process raft request' (duration: 561.57209ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:26.425867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:25.8638Z","time spent":"561.980828ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:12:59.487903Z","caller":"traceutil/trace.go:171","msg":"trace[350366586] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"137.224816ms","start":"2026-02-25T02:12:59.350643Z","end":"2026-02-25T02:12:59.487868Z","steps":["trace[350366586] 'process raft request' (duration: 136.922731ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:14.605009Z","caller":"traceutil/trace.go:171","msg":"trace[273289225] transaction","detail":"{read_only:false; response_revision:1766; number_of_response:1; }","duration":"136.672712ms","start":"2026-02-25T02:13:14.468303Z","end":"2026-02-25T02:13:14.604976Z","steps":["trace[273289225] 'process raft request' (duration: 56.963655ms)","trace[273289225] 'compare' (duration: 79.524514ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:13:25.804143Z","caller":"traceutil/trace.go:171","msg":"trace[2096064511] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"115.958268ms","start":"2026-02-25T02:13:25.68812Z","end":"2026-02-25T02:13:25.804078Z","steps":["trace[2096064511] 'process raft request' (duration: 28.043879ms)","trace[2096064511] 'compare' (duration: 87.614574ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:13:25.804212Z","caller":"traceutil/trace.go:171","msg":"trace[203145269] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"113.640905ms","start":"2026-02-25T02:13:25.69053Z","end":"2026-02-25T02:13:25.804171Z","steps":["trace[203145269] 'process raft request' (duration: 113.411181ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:25.804129Z","caller":"traceutil/trace.go:171","msg":"trace[940928344] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"113.191547ms","start":"2026-02-25T02:13:25.690863Z","end":"2026-02-25T02:13:25.804055Z","steps":["trace[940928344] 'process raft request' (duration: 113.130765ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:20:21.339509Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2249} {"level":"info","ts":"2026-02-25T02:20:21.396153Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2249,"took":"55.749486ms","hash":1249217110,"current-db-size-bytes":14503936,"current-db-size":"14 MB","current-db-size-in-use-bytes":4493312,"current-db-size-in-use":"4.5 MB"} {"level":"info","ts":"2026-02-25T02:20:21.396232Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1249217110,"revision":2249,"compact-revision":-1} {"level":"info","ts":"2026-02-25T02:23:02.993777Z","caller":"traceutil/trace.go:171","msg":"trace[1559751960] transaction","detail":"{read_only:false; response_revision:3901; number_of_response:1; }","duration":"110.704529ms","start":"2026-02-25T02:23:02.883043Z","end":"2026-02-25T02:23:02.993747Z","steps":["trace[1559751960] 'process raft request' (duration: 95.912437ms)","trace[1559751960] 'compare' (duration: 14.632819ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:23:02.993812Z","caller":"traceutil/trace.go:171","msg":"trace[1600368466] transaction","detail":"{read_only:false; response_revision:3902; number_of_response:1; }","duration":"110.671229ms","start":"2026-02-25T02:23:02.883116Z","end":"2026-02-25T02:23:02.993787Z","steps":["trace[1600368466] 'process raft request' (duration: 110.592777ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:23:02.994066Z","caller":"traceutil/trace.go:171","msg":"trace[544769761] transaction","detail":"{read_only:false; response_revision:3903; number_of_response:1; }","duration":"110.453734ms","start":"2026-02-25T02:23:02.88358Z","end":"2026-02-25T02:23:02.994034Z","steps":["trace[544769761] 'process raft request' (duration: 110.168569ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:23:15.247966Z","caller":"traceutil/trace.go:171","msg":"trace[885271736] linearizableReadLoop","detail":"{readStateIndex:4147; appliedIndex:4146; }","duration":"156.89318ms","start":"2026-02-25T02:23:15.091048Z","end":"2026-02-25T02:23:15.247941Z","steps":["trace[885271736] 'read index received' (duration: 89.418537ms)","trace[885271736] 'applied index is now lower than readState.Index' (duration: 67.473843ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:23:15.248115Z","caller":"traceutil/trace.go:171","msg":"trace[1485051706] transaction","detail":"{read_only:false; response_revision:3944; number_of_response:1; }","duration":"177.123622ms","start":"2026-02-25T02:23:15.070974Z","end":"2026-02-25T02:23:15.248097Z","steps":["trace[1485051706] 'process raft request' (duration: 109.512197ms)","trace[1485051706] 'compare' (duration: 67.33381ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:23:15.248367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.564617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-25T02:23:15.248377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.158621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:3875"} {"level":"info","ts":"2026-02-25T02:23:15.248455Z","caller":"traceutil/trace.go:171","msg":"trace[267321065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3944; }","duration":"123.7056ms","start":"2026-02-25T02:23:15.124727Z","end":"2026-02-25T02:23:15.248432Z","steps":["trace[267321065] 'agreement among raft nodes before linearized reading' (duration: 123.476156ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:23:15.248496Z","caller":"traceutil/trace.go:171","msg":"trace[48966844] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:3944; }","duration":"147.317713ms","start":"2026-02-25T02:23:15.101148Z","end":"2026-02-25T02:23:15.248466Z","steps":["trace[48966844] 'agreement among raft nodes before linearized reading' (duration: 147.005918ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:23:15.248771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.683335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T02:23:15.24906Z","caller":"traceutil/trace.go:171","msg":"trace[372230698] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3944; }","duration":"158.019391ms","start":"2026-02-25T02:23:15.091003Z","end":"2026-02-25T02:23:15.249022Z","steps":["trace[372230698] 'agreement among raft nodes before linearized reading' (duration: 157.206627ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:25:21.346333Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3321} {"level":"info","ts":"2026-02-25T02:25:21.368482Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3321,"took":"21.257483ms","hash":919859182,"current-db-size-bytes":14503936,"current-db-size":"14 MB","current-db-size-in-use-bytes":4890624,"current-db-size-in-use":"4.9 MB"} {"level":"info","ts":"2026-02-25T02:25:21.368551Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":919859182,"revision":3321,"compact-revision":2249}