{"level":"warn","ts":"2026-04-22T06:05:38.435315Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T06:05:38.435444Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-22T06:05:38.435551Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T06:05:38.435575Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-04-22T06:05:38.435612Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T06:05:38.436861Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-04-22T06:05:38.436989Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-22T06:05:38.440535Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.194726ms"} {"level":"info","ts":"2026-04-22T06:05:38.451305Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-04-22T06:05:38.451421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T06:05:38.451458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-04-22T06:05:38.451485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T06:05:38.451508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-04-22T06:05:38.451563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-04-22T06:05:38.456404Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T06:05:38.457955Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T06:05:38.459258Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-22T06:05:38.462158Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T06:05:38.462399Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T06:05:38.46248Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T06:05:38.46269Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T06:05:38.462722Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T06:05:38.464688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-04-22T06:05:38.464884Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-04-22T06:05:38.467106Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T06:05:38.467222Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-04-22T06:05:38.467282Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-04-22T06:05:38.46741Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T06:05:38.467448Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T06:05:39.052097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T06:05:39.05217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T06:05:39.052188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-04-22T06:05:39.0522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-04-22T06:05:39.052205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-04-22T06:05:39.052213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-04-22T06:05:39.05222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-04-22T06:05:39.052948Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T06:05:39.052989Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T06:05:39.05303Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:05:39.053064Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T06:05:39.053726Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T06:05:39.053781Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T06:05:39.054196Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:05:39.054288Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:05:39.05433Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:05:39.055276Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T06:05:39.056757Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-04-22T06:06:05.891641Z","caller":"traceutil/trace.go:171","msg":"trace[1268283107] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"154.739929ms","start":"2026-04-22T06:06:05.736873Z","end":"2026-04-22T06:06:05.891613Z","steps":["trace[1268283107] 'process raft request' (duration: 154.570425ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:14.491386Z","caller":"traceutil/trace.go:171","msg":"trace[397906246] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"476.681677ms","start":"2026-04-22T06:06:14.014678Z","end":"2026-04-22T06:06:14.49136Z","steps":["trace[397906246] 'process raft request' (duration: 476.527763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:14.49198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:14.014645Z","time spent":"476.825551ms","remote":"127.0.0.1:50718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:06:14.49635Z","caller":"traceutil/trace.go:171","msg":"trace[32030841] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"451.314652ms","start":"2026-04-22T06:06:14.045017Z","end":"2026-04-22T06:06:14.496331Z","steps":["trace[32030841] 'read index received' (duration: 446.294326ms)","trace[32030841] 'applied index is now lower than readState.Index' (duration: 5.019576ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:06:14.496443Z","caller":"traceutil/trace.go:171","msg":"trace[622901491] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"479.681718ms","start":"2026-04-22T06:06:14.016736Z","end":"2026-04-22T06:06:14.496418Z","steps":["trace[622901491] 'process raft request' (duration: 479.445532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:14.496477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.904554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:06:14.496538Z","caller":"traceutil/trace.go:171","msg":"trace[95734398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"114.983886ms","start":"2026-04-22T06:06:14.381546Z","end":"2026-04-22T06:06:14.49653Z","steps":["trace[95734398] 'agreement among raft nodes before linearized reading' (duration: 114.887634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:14.496536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.484777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-22T06:06:14.496588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:14.016706Z","time spent":"479.821852ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:06:14.496615Z","caller":"traceutil/trace.go:171","msg":"trace[1753936741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"451.628631ms","start":"2026-04-22T06:06:14.044967Z","end":"2026-04-22T06:06:14.496595Z","steps":["trace[1753936741] 'agreement among raft nodes before linearized reading' (duration: 451.455476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:14.496655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:14.044947Z","time spent":"451.699752ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-22T06:06:44.578071Z","caller":"traceutil/trace.go:171","msg":"trace[1541256615] linearizableReadLoop","detail":"{readStateIndex:971; appliedIndex:970; }","duration":"196.785415ms","start":"2026-04-22T06:06:44.381263Z","end":"2026-04-22T06:06:44.578048Z","steps":["trace[1541256615] 'read index received' (duration: 196.554419ms)","trace[1541256615] 'applied index is now lower than readState.Index' (duration: 229.866µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:06:44.578211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.93882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:06:44.578244Z","caller":"traceutil/trace.go:171","msg":"trace[591345353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:942; }","duration":"197.023062ms","start":"2026-04-22T06:06:44.381209Z","end":"2026-04-22T06:06:44.578232Z","steps":["trace[591345353] 'agreement among raft nodes before linearized reading' (duration: 196.956861ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:44.578317Z","caller":"traceutil/trace.go:171","msg":"trace[499641826] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"393.13603ms","start":"2026-04-22T06:06:44.185129Z","end":"2026-04-22T06:06:44.578265Z","steps":["trace[499641826] 'process raft request' (duration: 392.75326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:44.578529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:44.185105Z","time spent":"393.327835ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:07:40.871683Z","caller":"traceutil/trace.go:171","msg":"trace[1380045928] linearizableReadLoop","detail":"{readStateIndex:1885; appliedIndex:1884; }","duration":"236.247132ms","start":"2026-04-22T06:07:40.635414Z","end":"2026-04-22T06:07:40.871661Z","steps":["trace[1380045928] 'read index received' (duration: 236.102768ms)","trace[1380045928] 'applied index is now lower than readState.Index' (duration: 143.194µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:07:40.871756Z","caller":"traceutil/trace.go:171","msg":"trace[1483087350] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"311.387295ms","start":"2026-04-22T06:07:40.56033Z","end":"2026-04-22T06:07:40.871717Z","steps":["trace[1483087350] 'process raft request' (duration: 311.18603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:40.871833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.393276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:07:40.871879Z","caller":"traceutil/trace.go:171","msg":"trace[359689405] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1818; }","duration":"236.487559ms","start":"2026-04-22T06:07:40.635378Z","end":"2026-04-22T06:07:40.871866Z","steps":["trace[359689405] 'agreement among raft nodes before linearized reading' (duration: 236.401456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:40.87194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:40.560305Z","time spent":"311.533299ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:07:40.882672Z","caller":"traceutil/trace.go:171","msg":"trace[292894845] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"128.377373ms","start":"2026-04-22T06:07:40.754261Z","end":"2026-04-22T06:07:40.882638Z","steps":["trace[292894845] 'process raft request' (duration: 128.205248ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:41.021747Z","caller":"traceutil/trace.go:171","msg":"trace[1693499164] linearizableReadLoop","detail":"{readStateIndex:1887; appliedIndex:1886; }","duration":"116.114591ms","start":"2026-04-22T06:07:40.905612Z","end":"2026-04-22T06:07:41.021727Z","steps":["trace[1693499164] 'read index received' (duration: 74.442174ms)","trace[1693499164] 'applied index is now lower than readState.Index' (duration: 41.671677ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:07:41.021881Z","caller":"traceutil/trace.go:171","msg":"trace[920430310] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"131.890978ms","start":"2026-04-22T06:07:40.88994Z","end":"2026-04-22T06:07:41.021831Z","steps":["trace[920430310] 'process raft request' (duration: 90.1919ms)","trace[920430310] 'compare' (duration: 41.455631ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:07:41.022006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.702205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-22T06:07:41.021938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.320437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-22T06:07:41.022054Z","caller":"traceutil/trace.go:171","msg":"trace[1486950410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1820; }","duration":"110.792858ms","start":"2026-04-22T06:07:40.911249Z","end":"2026-04-22T06:07:41.022042Z","steps":["trace[1486950410] 'agreement among raft nodes before linearized reading' (duration: 110.615673ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:41.022068Z","caller":"traceutil/trace.go:171","msg":"trace[589048511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1820; }","duration":"116.509872ms","start":"2026-04-22T06:07:40.905549Z","end":"2026-04-22T06:07:41.022059Z","steps":["trace[589048511] 'agreement among raft nodes before linearized reading' (duration: 116.295216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:41.266502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.024486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2f081f4-1b41-4ed2-b10c-b5b4311112b5\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-22T06:07:41.26663Z","caller":"traceutil/trace.go:171","msg":"trace[1073066636] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e2f081f4-1b41-4ed2-b10c-b5b4311112b5; range_end:; response_count:1; response_revision:1823; }","duration":"144.176951ms","start":"2026-04-22T06:07:41.122417Z","end":"2026-04-22T06:07:41.266594Z","steps":["trace[1073066636] 'range keys from in-memory index tree' (duration: 143.923815ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:41.278589Z","caller":"traceutil/trace.go:171","msg":"trace[1297221511] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"113.784569ms","start":"2026-04-22T06:07:41.164775Z","end":"2026-04-22T06:07:41.278559Z","steps":["trace[1297221511] 'process raft request' (duration: 113.637435ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:14.523994Z","caller":"traceutil/trace.go:171","msg":"trace[1259699962] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"350.776901ms","start":"2026-04-22T06:08:14.173203Z","end":"2026-04-22T06:08:14.52398Z","steps":["trace[1259699962] 'process raft request' (duration: 350.608407ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:14.523996Z","caller":"traceutil/trace.go:171","msg":"trace[364294461] linearizableReadLoop","detail":"{readStateIndex:2134; appliedIndex:2133; }","duration":"235.034889ms","start":"2026-04-22T06:08:14.288931Z","end":"2026-04-22T06:08:14.523966Z","steps":["trace[364294461] 'read index received' (duration: 234.794102ms)","trace[364294461] 'applied index is now lower than readState.Index' (duration: 239.707µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:14.52413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:14.173183Z","time spent":"350.872633ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:14.524152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.208853ms","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-04-22T06:08:14.524222Z","caller":"traceutil/trace.go:171","msg":"trace[460437446] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2059; }","duration":"235.316076ms","start":"2026-04-22T06:08:14.288891Z","end":"2026-04-22T06:08:14.524207Z","steps":["trace[460437446] 'agreement among raft nodes before linearized reading' (duration: 235.110681ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:16.437252Z","caller":"traceutil/trace.go:171","msg":"trace[876504330] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"569.54386ms","start":"2026-04-22T06:08:15.867683Z","end":"2026-04-22T06:08:16.437227Z","steps":["trace[876504330] 'process raft request' (duration: 569.364395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:16.43742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:15.867667Z","time spent":"569.670424ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:30.798131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.830869ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:08:30.798255Z","caller":"traceutil/trace.go:171","msg":"trace[1016641385] linearizableReadLoop","detail":"{readStateIndex:2223; appliedIndex:2222; }","duration":"169.820999ms","start":"2026-04-22T06:08:30.628418Z","end":"2026-04-22T06:08:30.798239Z","steps":["trace[1016641385] 'read index received' (duration: 39.62301ms)","trace[1016641385] 'applied index is now lower than readState.Index' (duration: 130.196789ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:30.7983Z","caller":"traceutil/trace.go:171","msg":"trace[1117652315] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"202.111772ms","start":"2026-04-22T06:08:30.596158Z","end":"2026-04-22T06:08:30.79827Z","steps":["trace[1117652315] 'process raft request' (duration: 71.903023ms)","trace[1117652315] 'compare' (duration: 129.712816ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:30.79843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.018405ms","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-04-22T06:08:30.798466Z","caller":"traceutil/trace.go:171","msg":"trace[1688385473] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2145; }","duration":"170.093537ms","start":"2026-04-22T06:08:30.628364Z","end":"2026-04-22T06:08:30.798457Z","steps":["trace[1688385473] 'agreement among raft nodes before linearized reading' (duration: 169.961274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:30.79872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.011874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-22T06:08:30.798769Z","caller":"traceutil/trace.go:171","msg":"trace[2121997439] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2145; }","duration":"157.106716ms","start":"2026-04-22T06:08:30.641647Z","end":"2026-04-22T06:08:30.798754Z","steps":["trace[2121997439] 'agreement among raft nodes before linearized reading' (duration: 156.955842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:31.122374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.61791ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:08:31.12252Z","caller":"traceutil/trace.go:171","msg":"trace[2123596642] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"319.244788ms","start":"2026-04-22T06:08:30.803249Z","end":"2026-04-22T06:08:31.122494Z","steps":["trace[2123596642] 'process raft request' (duration: 107.400052ms)","trace[2123596642] 'compare' (duration: 211.388794ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:31.122616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:30.803226Z","time spent":"319.339491ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:08:31.159169Z","caller":"traceutil/trace.go:171","msg":"trace[1979526728] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"101.74852ms","start":"2026-04-22T06:08:31.057385Z","end":"2026-04-22T06:08:31.159134Z","steps":["trace[1979526728] 'process raft request' (duration: 101.600076ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:31.164742Z","caller":"traceutil/trace.go:171","msg":"trace[684823134] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"100.187148ms","start":"2026-04-22T06:08:31.064527Z","end":"2026-04-22T06:08:31.164714Z","steps":["trace[684823134] 'process raft request' (duration: 100.049104ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:09:53.014861Z","caller":"traceutil/trace.go:171","msg":"trace[1675174050] transaction","detail":"{read_only:false; response_revision:2785; number_of_response:1; }","duration":"120.37737ms","start":"2026-04-22T06:09:52.894457Z","end":"2026-04-22T06:09:53.014834Z","steps":["trace[1675174050] 'process raft request' (duration: 120.165005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:13:39.025044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.517274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-04-22T06:13:39.025146Z","caller":"traceutil/trace.go:171","msg":"trace[1040459061] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4802; }","duration":"102.637388ms","start":"2026-04-22T06:13:38.922484Z","end":"2026-04-22T06:13:39.025122Z","steps":["trace[1040459061] 'agreement among raft nodes before linearized reading' (duration: 102.291429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:13:42.790866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.227629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jjxmx\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-22T06:13:42.790958Z","caller":"traceutil/trace.go:171","msg":"trace[1527180168] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jjxmx; range_end:; response_count:1; response_revision:4941; }","duration":"232.353122ms","start":"2026-04-22T06:13:42.558587Z","end":"2026-04-22T06:13:42.79094Z","steps":["trace[1527180168] 'range keys from in-memory index tree' (duration: 232.100276ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:13:42.79119Z","caller":"traceutil/trace.go:171","msg":"trace[476391035] linearizableReadLoop","detail":"{readStateIndex:5125; appliedIndex:5124; }","duration":"168.276591ms","start":"2026-04-22T06:13:42.622884Z","end":"2026-04-22T06:13:42.79116Z","steps":["trace[476391035] 'read index received' (duration: 102.645019ms)","trace[476391035] 'applied index is now lower than readState.Index' (duration: 65.630522ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:13:42.791216Z","caller":"traceutil/trace.go:171","msg":"trace[648167582] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"222.812753ms","start":"2026-04-22T06:13:42.568373Z","end":"2026-04-22T06:13:42.791186Z","steps":["trace[648167582] 'process raft request' (duration: 157.216711ms)","trace[648167582] 'compare' (duration: 65.407127ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:13:42.791372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.492278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9ada8515-c313-4960-ae93-88cd6b363597\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-22T06:13:42.791417Z","caller":"traceutil/trace.go:171","msg":"trace[1602058299] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9ada8515-c313-4960-ae93-88cd6b363597; range_end:; response_count:1; response_revision:4942; }","duration":"168.58231ms","start":"2026-04-22T06:13:42.622824Z","end":"2026-04-22T06:13:42.791406Z","steps":["trace[1602058299] 'agreement among raft nodes before linearized reading' (duration: 168.477957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:13:42.791502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.286108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-whwdr.18a89920e6e4ffce\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-04-22T06:13:42.791564Z","caller":"traceutil/trace.go:171","msg":"trace[50728205] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-whwdr.18a89920e6e4ffce; range_end:; response_count:1; response_revision:4942; }","duration":"166.37807ms","start":"2026-04-22T06:13:42.625169Z","end":"2026-04-22T06:13:42.791547Z","steps":["trace[50728205] 'agreement among raft nodes before linearized reading' (duration: 166.171114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:13:42.791617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.021144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-22T06:13:42.791654Z","caller":"traceutil/trace.go:171","msg":"trace[420779323] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4942; }","duration":"147.092256ms","start":"2026-04-22T06:13:42.644553Z","end":"2026-04-22T06:13:42.791646Z","steps":["trace[420779323] 'agreement among raft nodes before linearized reading' (duration: 146.959672ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:13:44.939441Z","caller":"traceutil/trace.go:171","msg":"trace[1302784744] transaction","detail":"{read_only:false; response_revision:4983; number_of_response:1; }","duration":"143.081727ms","start":"2026-04-22T06:13:44.796326Z","end":"2026-04-22T06:13:44.939407Z","steps":["trace[1302784744] 'process raft request' (duration: 82.517982ms)","trace[1302784744] 'compare' (duration: 60.347449ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:13:53.892631Z","caller":"traceutil/trace.go:171","msg":"trace[1351976171] transaction","detail":"{read_only:false; response_revision:5174; number_of_response:1; }","duration":"108.214703ms","start":"2026-04-22T06:13:53.784397Z","end":"2026-04-22T06:13:53.892611Z","steps":["trace[1351976171] 'process raft request' (duration: 51.890301ms)","trace[1351976171] 'compare' (duration: 56.195708ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:13:53.892906Z","caller":"traceutil/trace.go:171","msg":"trace[2057616792] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"105.978311ms","start":"2026-04-22T06:13:53.78692Z","end":"2026-04-22T06:13:53.892898Z","steps":["trace[2057616792] 'process raft request' (duration: 105.651402ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:13:53.893218Z","caller":"traceutil/trace.go:171","msg":"trace[1321895232] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"100.620096ms","start":"2026-04-22T06:13:53.79259Z","end":"2026-04-22T06:13:53.89321Z","steps":["trace[1321895232] 'process raft request' (duration: 100.197064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:13:54.172661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.900803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:13:54.173022Z","caller":"traceutil/trace.go:171","msg":"trace[393716537] transaction","detail":"{read_only:false; response_revision:5179; number_of_response:1; }","duration":"274.612478ms","start":"2026-04-22T06:13:53.898378Z","end":"2026-04-22T06:13:54.17299Z","steps":["trace[393716537] 'process raft request' (duration: 105.112279ms)","trace[393716537] 'compare' (duration: 168.450721ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:13:54.173468Z","caller":"traceutil/trace.go:171","msg":"trace[1769718966] transaction","detail":"{read_only:false; response_revision:5180; number_of_response:1; }","duration":"275.076411ms","start":"2026-04-22T06:13:53.898383Z","end":"2026-04-22T06:13:54.173459Z","steps":["trace[1769718966] 'process raft request' (duration: 274.436754ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:13:54.174061Z","caller":"traceutil/trace.go:171","msg":"trace[2082319255] linearizableReadLoop","detail":"{readStateIndex:5371; appliedIndex:5368; }","duration":"261.111161ms","start":"2026-04-22T06:13:53.912925Z","end":"2026-04-22T06:13:54.174037Z","steps":["trace[2082319255] 'read index received' (duration: 90.520892ms)","trace[2082319255] 'applied index is now lower than readState.Index' (duration: 170.588999ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:13:54.174591Z","caller":"traceutil/trace.go:171","msg":"trace[605866234] transaction","detail":"{read_only:false; response_revision:5181; number_of_response:1; }","duration":"276.100498ms","start":"2026-04-22T06:13:53.898469Z","end":"2026-04-22T06:13:54.174569Z","steps":["trace[605866234] 'process raft request' (duration: 274.617608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:13:54.17504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.101228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-whwdr.18a89920aa9ef3a6\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-04-22T06:13:54.175157Z","caller":"traceutil/trace.go:171","msg":"trace[1459360827] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-whwdr.18a89920aa9ef3a6; range_end:; response_count:1; response_revision:5181; }","duration":"262.232191ms","start":"2026-04-22T06:13:53.912903Z","end":"2026-04-22T06:13:54.175135Z","steps":["trace[1459360827] 'agreement among raft nodes before linearized reading' (duration: 262.034245ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:01.163403Z","caller":"traceutil/trace.go:171","msg":"trace[102163468] linearizableReadLoop","detail":"{readStateIndex:5537; appliedIndex:5536; }","duration":"146.483033ms","start":"2026-04-22T06:14:01.016899Z","end":"2026-04-22T06:14:01.163382Z","steps":["trace[102163468] 'read index received' (duration: 146.328319ms)","trace[102163468] 'applied index is now lower than readState.Index' (duration: 153.574µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:14:01.163541Z","caller":"traceutil/trace.go:171","msg":"trace[900303742] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"174.329291ms","start":"2026-04-22T06:14:00.989202Z","end":"2026-04-22T06:14:01.163531Z","steps":["trace[900303742] 'process raft request' (duration: 174.036253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:14:01.163767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.510491ms","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-04-22T06:14:01.163837Z","caller":"traceutil/trace.go:171","msg":"trace[556533268] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5343; }","duration":"122.630895ms","start":"2026-04-22T06:14:01.041189Z","end":"2026-04-22T06:14:01.163819Z","steps":["trace[556533268] 'agreement among raft nodes before linearized reading' (duration: 122.452761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:14:01.164037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.593797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-22T06:14:01.164025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.09848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jjxmx\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-22T06:14:01.164127Z","caller":"traceutil/trace.go:171","msg":"trace[921496611] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5343; }","duration":"121.72576ms","start":"2026-04-22T06:14:01.042385Z","end":"2026-04-22T06:14:01.164111Z","steps":["trace[921496611] 'agreement among raft nodes before linearized reading' (duration: 121.534955ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:01.164155Z","caller":"traceutil/trace.go:171","msg":"trace[1841286134] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jjxmx; range_end:; response_count:1; response_revision:5343; }","duration":"147.262665ms","start":"2026-04-22T06:14:01.016861Z","end":"2026-04-22T06:14:01.164123Z","steps":["trace[1841286134] 'agreement among raft nodes before linearized reading' (duration: 146.980257ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:01.387586Z","caller":"traceutil/trace.go:171","msg":"trace[1087555110] linearizableReadLoop","detail":"{readStateIndex:5538; appliedIndex:5537; }","duration":"219.205991ms","start":"2026-04-22T06:14:01.168358Z","end":"2026-04-22T06:14:01.387564Z","steps":["trace[1087555110] 'read index received' (duration: 121.702609ms)","trace[1087555110] 'applied index is now lower than readState.Index' (duration: 97.502442ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:14:01.387635Z","caller":"traceutil/trace.go:171","msg":"trace[454572017] transaction","detail":"{read_only:false; response_revision:5344; number_of_response:1; }","duration":"219.322924ms","start":"2026-04-22T06:14:01.16829Z","end":"2026-04-22T06:14:01.387613Z","steps":["trace[454572017] 'process raft request' (duration: 121.756651ms)","trace[454572017] 'compare' (duration: 97.352337ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:14:01.387847Z","caller":"traceutil/trace.go:171","msg":"trace[1128011907] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"219.611502ms","start":"2026-04-22T06:14:01.168204Z","end":"2026-04-22T06:14:01.387816Z","steps":["trace[1128011907] 'process raft request' (duration: 219.321164ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:01.388568Z","caller":"traceutil/trace.go:171","msg":"trace[1671407985] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"220.097846ms","start":"2026-04-22T06:14:01.168449Z","end":"2026-04-22T06:14:01.388547Z","steps":["trace[1671407985] 'process raft request' (duration: 219.269713ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:01.388651Z","caller":"traceutil/trace.go:171","msg":"trace[1407490478] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"219.272023ms","start":"2026-04-22T06:14:01.169364Z","end":"2026-04-22T06:14:01.388636Z","steps":["trace[1407490478] 'process raft request' (duration: 218.948544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:14:01.389028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.65029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80099"} {"level":"info","ts":"2026-04-22T06:14:01.389078Z","caller":"traceutil/trace.go:171","msg":"trace[899273252] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5345; }","duration":"220.737133ms","start":"2026-04-22T06:14:01.16833Z","end":"2026-04-22T06:14:01.389067Z","steps":["trace[899273252] 'agreement among raft nodes before linearized reading' (duration: 219.322924ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:51.285921Z","caller":"traceutil/trace.go:171","msg":"trace[595748513] transaction","detail":"{read_only:false; response_revision:5830; number_of_response:1; }","duration":"111.34233ms","start":"2026-04-22T06:14:51.174559Z","end":"2026-04-22T06:14:51.285902Z","steps":["trace[595748513] 'process raft request' (duration: 111.212097ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:15:06.074556Z","caller":"traceutil/trace.go:171","msg":"trace[1277469152] linearizableReadLoop","detail":"{readStateIndex:6155; appliedIndex:6154; }","duration":"341.29667ms","start":"2026-04-22T06:15:05.73323Z","end":"2026-04-22T06:15:06.074527Z","steps":["trace[1277469152] 'read index received' (duration: 341.155257ms)","trace[1277469152] 'applied index is now lower than readState.Index' (duration: 139.613µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:15:06.074684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.445494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:15:06.074595Z","caller":"traceutil/trace.go:171","msg":"trace[207208957] transaction","detail":"{read_only:false; response_revision:5945; number_of_response:1; }","duration":"582.566378ms","start":"2026-04-22T06:15:05.492001Z","end":"2026-04-22T06:15:06.074568Z","steps":["trace[207208957] 'process raft request' (duration: 582.308751ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:15:06.074712Z","caller":"traceutil/trace.go:171","msg":"trace[1637033358] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:5945; }","duration":"341.528246ms","start":"2026-04-22T06:15:05.733177Z","end":"2026-04-22T06:15:06.074705Z","steps":["trace[1637033358] 'agreement among raft nodes before linearized reading' (duration: 341.464815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:15:06.074741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:15:05.733154Z","time spent":"341.571118ms","remote":"127.0.0.1:58662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"warn","ts":"2026-04-22T06:15:06.074829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:15:05.491976Z","time spent":"582.751893ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:15:06.074865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.35428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-22T06:15:06.074903Z","caller":"traceutil/trace.go:171","msg":"trace[207753881] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5945; }","duration":"331.458972ms","start":"2026-04-22T06:15:05.743434Z","end":"2026-04-22T06:15:06.074892Z","steps":["trace[207753881] 'agreement among raft nodes before linearized reading' (duration: 331.298768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:15:06.074938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:15:05.743416Z","time spent":"331.514654ms","remote":"127.0.0.1:50802","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-04-22T06:15:06.075011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.729753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-22T06:15:06.074988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.994353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-22T06:15:06.075001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.419454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jjxmx\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-22T06:15:06.07504Z","caller":"traceutil/trace.go:171","msg":"trace[495716980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5945; }","duration":"215.757753ms","start":"2026-04-22T06:15:05.859275Z","end":"2026-04-22T06:15:06.075032Z","steps":["trace[495716980] 'agreement among raft nodes before linearized reading' (duration: 215.688401ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:15:06.075061Z","caller":"traceutil/trace.go:171","msg":"trace[302702523] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:5945; }","duration":"258.136597ms","start":"2026-04-22T06:15:05.816907Z","end":"2026-04-22T06:15:06.075044Z","steps":["trace[302702523] 'agreement among raft nodes before linearized reading' (duration: 257.951972ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:15:06.075077Z","caller":"traceutil/trace.go:171","msg":"trace[1565375867] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jjxmx; range_end:; response_count:1; response_revision:5945; }","duration":"330.510527ms","start":"2026-04-22T06:15:05.744546Z","end":"2026-04-22T06:15:06.075057Z","steps":["trace[1565375867] 'agreement among raft nodes before linearized reading' (duration: 330.315152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:15:06.075111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.813222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-22T06:15:06.07519Z","caller":"traceutil/trace.go:171","msg":"trace[1710154761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5945; }","duration":"241.936135ms","start":"2026-04-22T06:15:05.833234Z","end":"2026-04-22T06:15:06.07517Z","steps":["trace[1710154761] 'agreement among raft nodes before linearized reading' (duration: 241.721239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:15:06.075128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:15:05.744535Z","time spent":"330.578679ms","remote":"127.0.0.1:50718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6552,"request content":"key:\"/registry/pods/openstack/keepalived-jjxmx\" "} {"level":"warn","ts":"2026-04-22T06:15:06.075342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.701836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-22T06:15:06.075403Z","caller":"traceutil/trace.go:171","msg":"trace[1125300049] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5945; }","duration":"217.799949ms","start":"2026-04-22T06:15:05.85759Z","end":"2026-04-22T06:15:06.07539Z","steps":["trace[1125300049] 'agreement among raft nodes before linearized reading' (duration: 217.203103ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:15:09.922554Z","caller":"traceutil/trace.go:171","msg":"trace[1335620345] transaction","detail":"{read_only:false; response_revision:5987; number_of_response:1; }","duration":"535.857936ms","start":"2026-04-22T06:15:09.386678Z","end":"2026-04-22T06:15:09.922536Z","steps":["trace[1335620345] 'process raft request' (duration: 535.745513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:15:09.92267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:15:09.386662Z","time spent":"535.948148ms","remote":"127.0.0.1:50778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5982,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:15:39.084637Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3036} {"level":"info","ts":"2026-04-22T06:15:39.202428Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3036,"took":"116.025408ms","hash":2895637631,"current-db-size-bytes":58728448,"current-db-size":"59 MB","current-db-size-in-use-bytes":32321536,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-22T06:15:39.202496Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2895637631,"revision":3036,"compact-revision":-1} {"level":"warn","ts":"2026-04-22T06:16:07.525842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.916374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-22T06:16:07.525928Z","caller":"traceutil/trace.go:171","msg":"trace[455204517] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6364; }","duration":"229.040307ms","start":"2026-04-22T06:16:07.296864Z","end":"2026-04-22T06:16:07.525904Z","steps":["trace[455204517] 'range keys from in-memory index tree' (duration: 228.709188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:16:07.526074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.753864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-22T06:16:07.526137Z","caller":"traceutil/trace.go:171","msg":"trace[1657873401] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6364; }","duration":"738.871437ms","start":"2026-04-22T06:16:06.787251Z","end":"2026-04-22T06:16:07.526123Z","steps":["trace[1657873401] 'range keys from in-memory index tree' (duration: 738.603589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:16:07.526137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.19904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:16:07.526243Z","caller":"traceutil/trace.go:171","msg":"trace[1864999265] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6364; }","duration":"144.346264ms","start":"2026-04-22T06:16:07.38187Z","end":"2026-04-22T06:16:07.526216Z","steps":["trace[1864999265] 'range keys from in-memory index tree' (duration: 144.118037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:16:07.526174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:16:06.787234Z","time spent":"738.932868ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T06:16:12.896992Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868899445361909,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T06:16:12.965427Z","caller":"traceutil/trace.go:171","msg":"trace[1695926271] transaction","detail":"{read_only:false; response_revision:6386; number_of_response:1; }","duration":"775.222021ms","start":"2026-04-22T06:16:12.190168Z","end":"2026-04-22T06:16:12.96539Z","steps":["trace[1695926271] 'process raft request' (duration: 761.659471ms)","trace[1695926271] 'compare' (duration: 12.905602ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:16:12.965612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:16:12.190143Z","time spent":"775.380555ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:16:12.969191Z","caller":"traceutil/trace.go:171","msg":"trace[1130007452] linearizableReadLoop","detail":"{readStateIndex:6614; appliedIndex:6610; }","duration":"572.558884ms","start":"2026-04-22T06:16:12.396615Z","end":"2026-04-22T06:16:12.969174Z","steps":["trace[1130007452] 'read index received' (duration: 555.298212ms)","trace[1130007452] 'applied index is now lower than readState.Index' (duration: 17.259482ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:16:12.969252Z","caller":"traceutil/trace.go:171","msg":"trace[991961109] transaction","detail":"{read_only:false; response_revision:6387; number_of_response:1; }","duration":"668.516276ms","start":"2026-04-22T06:16:12.300718Z","end":"2026-04-22T06:16:12.969235Z","steps":["trace[991961109] 'process raft request' (duration: 668.29794ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:16:12.969291Z","caller":"traceutil/trace.go:171","msg":"trace[1848041192] transaction","detail":"{read_only:false; response_revision:6388; number_of_response:1; }","duration":"220.735281ms","start":"2026-04-22T06:16:12.748545Z","end":"2026-04-22T06:16:12.969281Z","steps":["trace[1848041192] 'process raft request' (duration: 220.554796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:16:12.969332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:16:12.300691Z","time spent":"668.600468ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:16:12.969498Z","caller":"traceutil/trace.go:171","msg":"trace[2034124192] transaction","detail":"{read_only:false; response_revision:6389; number_of_response:1; }","duration":"220.801103ms","start":"2026-04-22T06:16:12.748644Z","end":"2026-04-22T06:16:12.969446Z","steps":["trace[2034124192] 'process raft request' (duration: 220.496775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:16:12.969609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.43543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-22T06:16:12.969555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.049541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jjxmx\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-22T06:16:12.969659Z","caller":"traceutil/trace.go:171","msg":"trace[1460703494] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6389; }","duration":"572.683778ms","start":"2026-04-22T06:16:12.396963Z","end":"2026-04-22T06:16:12.969647Z","steps":["trace[1460703494] 'agreement among raft nodes before linearized reading' (duration: 572.418001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:16:12.969708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:16:12.396948Z","time spent":"572.748859ms","remote":"127.0.0.1:50802","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":"info","ts":"2026-04-22T06:16:12.969719Z","caller":"traceutil/trace.go:171","msg":"trace[1776813469] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jjxmx; range_end:; response_count:1; response_revision:6389; }","duration":"564.214086ms","start":"2026-04-22T06:16:12.405477Z","end":"2026-04-22T06:16:12.969691Z","steps":["trace[1776813469] 'agreement among raft nodes before linearized reading' (duration: 563.99045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:16:12.969787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:16:12.405465Z","time spent":"564.297118ms","remote":"127.0.0.1:50718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6552,"request content":"key:\"/registry/pods/openstack/keepalived-jjxmx\" "} {"level":"warn","ts":"2026-04-22T06:16:12.96976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.099376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-22T06:16:12.969927Z","caller":"traceutil/trace.go:171","msg":"trace[1186513059] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6389; }","duration":"570.284182ms","start":"2026-04-22T06:16:12.399591Z","end":"2026-04-22T06:16:12.969875Z","steps":["trace[1186513059] 'agreement among raft nodes before linearized reading' (duration: 569.881051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:16:12.970007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:16:12.399584Z","time spent":"570.386115ms","remote":"127.0.0.1:50802","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-04-22T06:16:12.970039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.422087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-22T06:16:12.969981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.396702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-22T06:16:12.970106Z","caller":"traceutil/trace.go:171","msg":"trace[4301452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6389; }","duration":"573.52273ms","start":"2026-04-22T06:16:12.396569Z","end":"2026-04-22T06:16:12.970092Z","steps":["trace[4301452] 'agreement among raft nodes before linearized reading' (duration: 572.734328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:16:12.97014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:16:12.39655Z","time spent":"573.582842ms","remote":"127.0.0.1:50802","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":"info","ts":"2026-04-22T06:16:12.970213Z","caller":"traceutil/trace.go:171","msg":"trace[2079720046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6389; }","duration":"571.645609ms","start":"2026-04-22T06:16:12.398522Z","end":"2026-04-22T06:16:12.970167Z","steps":["trace[2079720046] 'agreement among raft nodes before linearized reading' (duration: 571.045483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:16:12.970419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:16:12.398507Z","time spent":"571.764412ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T06:19:06.909714Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868899445365355,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T06:19:07.164447Z","caller":"traceutil/trace.go:171","msg":"trace[490876307] transaction","detail":"{read_only:false; response_revision:7649; number_of_response:1; }","duration":"786.096268ms","start":"2026-04-22T06:19:06.378327Z","end":"2026-04-22T06:19:07.164423Z","steps":["trace[490876307] 'process raft request' (duration: 785.900372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:07.164592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:06.378313Z","time spent":"786.20834ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:19:07.165107Z","caller":"traceutil/trace.go:171","msg":"trace[775204807] linearizableReadLoop","detail":"{readStateIndex:7917; appliedIndex:7914; }","duration":"755.860642ms","start":"2026-04-22T06:19:06.409229Z","end":"2026-04-22T06:19:07.165089Z","steps":["trace[775204807] 'read index received' (duration: 755.04872ms)","trace[775204807] 'applied index is now lower than readState.Index' (duration: 811.322µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:19:07.165275Z","caller":"traceutil/trace.go:171","msg":"trace[2091136760] transaction","detail":"{read_only:false; response_revision:7650; number_of_response:1; }","duration":"500.023304ms","start":"2026-04-22T06:19:06.665241Z","end":"2026-04-22T06:19:07.165265Z","steps":["trace[2091136760] 'process raft request' (duration: 499.747327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:07.165351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:06.665218Z","time spent":"500.081056ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:19:07.165585Z","caller":"traceutil/trace.go:171","msg":"trace[1983311685] transaction","detail":"{read_only:false; response_revision:7651; number_of_response:1; }","duration":"424.261856ms","start":"2026-04-22T06:19:06.741312Z","end":"2026-04-22T06:19:07.165574Z","steps":["trace[1983311685] 'process raft request' (duration: 423.751502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:07.165634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:06.741283Z","time spent":"424.330018ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:19:07.165644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.413756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-22T06:19:07.165729Z","caller":"traceutil/trace.go:171","msg":"trace[1893277797] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7651; }","duration":"756.53042ms","start":"2026-04-22T06:19:06.409184Z","end":"2026-04-22T06:19:07.165715Z","steps":["trace[1893277797] 'agreement among raft nodes before linearized reading' (duration: 756.343305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:07.165804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.812577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-22T06:19:07.16583Z","caller":"traceutil/trace.go:171","msg":"trace[969589159] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:7651; }","duration":"719.869979ms","start":"2026-04-22T06:19:06.445953Z","end":"2026-04-22T06:19:07.165823Z","steps":["trace[969589159] 'agreement among raft nodes before linearized reading' (duration: 719.771676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:07.165869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:06.445937Z","time spent":"719.92463ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-22T06:19:07.165923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:06.409167Z","time spent":"756.622802ms","remote":"127.0.0.1:50718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-22T06:19:07.165803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.78295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-22T06:19:07.166074Z","caller":"traceutil/trace.go:171","msg":"trace[779608132] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7651; }","duration":"748.099139ms","start":"2026-04-22T06:19:06.417954Z","end":"2026-04-22T06:19:07.166053Z","steps":["trace[779608132] 'agreement among raft nodes before linearized reading' (duration: 747.580375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:07.166131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:06.417937Z","time spent":"748.178382ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-04-22T06:19:09.486609Z","caller":"traceutil/trace.go:171","msg":"trace[736685648] transaction","detail":"{read_only:false; response_revision:7663; number_of_response:1; }","duration":"255.298752ms","start":"2026-04-22T06:19:09.231262Z","end":"2026-04-22T06:19:09.486561Z","steps":["trace[736685648] 'process raft request' (duration: 253.989446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:52.207253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.592948ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:19:52.207375Z","caller":"traceutil/trace.go:171","msg":"trace[1076485511] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8088; }","duration":"152.722472ms","start":"2026-04-22T06:19:52.054635Z","end":"2026-04-22T06:19:52.207358Z","steps":["trace[1076485511] 'range keys from in-memory index tree' (duration: 152.581038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:52.207486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.294958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:19:52.207878Z","caller":"traceutil/trace.go:171","msg":"trace[1241550895] transaction","detail":"{read_only:false; response_revision:8090; number_of_response:1; }","duration":"422.770136ms","start":"2026-04-22T06:19:51.785093Z","end":"2026-04-22T06:19:52.207863Z","steps":["trace[1241550895] 'process raft request' (duration: 422.504689ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:19:52.207916Z","caller":"traceutil/trace.go:171","msg":"trace[678730390] transaction","detail":"{read_only:false; response_revision:8089; number_of_response:1; }","duration":"429.335606ms","start":"2026-04-22T06:19:51.77853Z","end":"2026-04-22T06:19:52.207865Z","steps":["trace[678730390] 'process raft request' (duration: 138.557084ms)","trace[678730390] 'compare' (duration: 290.076782ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:19:52.207976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:51.785066Z","time spent":"422.850789ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:19:52.207952Z","caller":"traceutil/trace.go:171","msg":"trace[712097845] linearizableReadLoop","detail":"{readStateIndex:8368; appliedIndex:8366; }","duration":"217.635454ms","start":"2026-04-22T06:19:51.990297Z","end":"2026-04-22T06:19:52.207932Z","steps":["trace[712097845] 'read index received' (duration: 217.092019ms)","trace[712097845] 'applied index is now lower than readState.Index' (duration: 541.035µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:19:52.208147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:51.778517Z","time spent":"429.47061ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:19:52.208177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.85727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-22T06:19:52.208234Z","caller":"traceutil/trace.go:171","msg":"trace[933110414] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:8090; }","duration":"217.966073ms","start":"2026-04-22T06:19:51.990253Z","end":"2026-04-22T06:19:52.208219Z","steps":["trace[933110414] 'agreement among raft nodes before linearized reading' (duration: 217.743627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:52.208306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.921422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-22T06:19:52.20853Z","caller":"traceutil/trace.go:171","msg":"trace[1354053163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8090; }","duration":"166.182819ms","start":"2026-04-22T06:19:52.042324Z","end":"2026-04-22T06:19:52.208507Z","steps":["trace[1354053163] 'agreement among raft nodes before linearized reading' (duration: 165.797659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:19:52.208572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.621463ms","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-04-22T06:19:52.208655Z","caller":"traceutil/trace.go:171","msg":"trace[803601312] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8090; }","duration":"165.728697ms","start":"2026-04-22T06:19:52.042873Z","end":"2026-04-22T06:19:52.208602Z","steps":["trace[803601312] 'agreement among raft nodes before linearized reading' (duration: 165.430659ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:03.939162Z","caller":"traceutil/trace.go:171","msg":"trace[543650064] transaction","detail":"{read_only:false; response_revision:8151; number_of_response:1; }","duration":"128.86707ms","start":"2026-04-22T06:20:03.810269Z","end":"2026-04-22T06:20:03.939136Z","steps":["trace[543650064] 'process raft request' (duration: 128.645324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:20:06.059851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.311346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-04-22T06:20:06.059921Z","caller":"traceutil/trace.go:171","msg":"trace[2137769710] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:8161; }","duration":"120.421539ms","start":"2026-04-22T06:20:05.939484Z","end":"2026-04-22T06:20:06.059905Z","steps":["trace[2137769710] 'range keys from in-memory index tree' (duration: 120.069059ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:06.059982Z","caller":"traceutil/trace.go:171","msg":"trace[1494511151] transaction","detail":"{read_only:false; response_revision:8162; number_of_response:1; }","duration":"116.43818ms","start":"2026-04-22T06:20:05.943518Z","end":"2026-04-22T06:20:06.059956Z","steps":["trace[1494511151] 'process raft request' (duration: 115.835103ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:32.556962Z","caller":"traceutil/trace.go:171","msg":"trace[16644662] transaction","detail":"{read_only:false; response_revision:8358; number_of_response:1; }","duration":"209.062977ms","start":"2026-04-22T06:20:32.347874Z","end":"2026-04-22T06:20:32.556937Z","steps":["trace[16644662] 'process raft request' (duration: 208.920833ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:32.557035Z","caller":"traceutil/trace.go:171","msg":"trace[1123193869] linearizableReadLoop","detail":"{readStateIndex:8648; appliedIndex:8648; }","duration":"171.639674ms","start":"2026-04-22T06:20:32.385358Z","end":"2026-04-22T06:20:32.556998Z","steps":["trace[1123193869] 'read index received' (duration: 171.621474ms)","trace[1123193869] 'applied index is now lower than readState.Index' (duration: 15.39µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:20:32.557178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.811558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:20:32.557228Z","caller":"traceutil/trace.go:171","msg":"trace[2035618805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8358; }","duration":"171.905191ms","start":"2026-04-22T06:20:32.385312Z","end":"2026-04-22T06:20:32.557217Z","steps":["trace[2035618805] 'agreement among raft nodes before linearized reading' (duration: 171.821689ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:32.696056Z","caller":"traceutil/trace.go:171","msg":"trace[1154248282] linearizableReadLoop","detail":"{readStateIndex:8649; appliedIndex:8648; }","duration":"138.910819ms","start":"2026-04-22T06:20:32.55711Z","end":"2026-04-22T06:20:32.696021Z","steps":["trace[1154248282] 'read index received' (duration: 104.683073ms)","trace[1154248282] 'applied index is now lower than readState.Index' (duration: 34.226516ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:20:32.696229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.519154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-22T06:20:32.696274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.945462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:20:32.696287Z","caller":"traceutil/trace.go:171","msg":"trace[1488480163] transaction","detail":"{read_only:false; response_revision:8359; number_of_response:1; }","duration":"307.148299ms","start":"2026-04-22T06:20:32.389098Z","end":"2026-04-22T06:20:32.696246Z","steps":["trace[1488480163] 'process raft request' (duration: 272.712967ms)","trace[1488480163] 'compare' (duration: 34.080472ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:20:32.696308Z","caller":"traceutil/trace.go:171","msg":"trace[9790987] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8359; }","duration":"245.645227ms","start":"2026-04-22T06:20:32.450645Z","end":"2026-04-22T06:20:32.69629Z","steps":["trace[9790987] 'agreement among raft nodes before linearized reading' (duration: 245.468212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:20:32.69632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.79393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-22T06:20:32.696297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.546178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-22T06:20:32.696246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.493773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:20:32.696368Z","caller":"traceutil/trace.go:171","msg":"trace[1442720554] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8359; }","duration":"242.834691ms","start":"2026-04-22T06:20:32.453516Z","end":"2026-04-22T06:20:32.696351Z","steps":["trace[1442720554] 'agreement among raft nodes before linearized reading' (duration: 242.766179ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:32.69638Z","caller":"traceutil/trace.go:171","msg":"trace[280629747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8359; }","duration":"245.644857ms","start":"2026-04-22T06:20:32.450723Z","end":"2026-04-22T06:20:32.696368Z","steps":["trace[280629747] 'agreement among raft nodes before linearized reading' (duration: 245.342829ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:32.696386Z","caller":"traceutil/trace.go:171","msg":"trace[1601335033] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8359; }","duration":"255.680462ms","start":"2026-04-22T06:20:32.440685Z","end":"2026-04-22T06:20:32.696366Z","steps":["trace[1601335033] 'agreement among raft nodes before linearized reading' (duration: 255.489977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:20:32.696405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:20:32.389064Z","time spent":"307.279183ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:20:32.696319Z","caller":"traceutil/trace.go:171","msg":"trace[2122826788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8359; }","duration":"138.031684ms","start":"2026-04-22T06:20:32.558273Z","end":"2026-04-22T06:20:32.696304Z","steps":["trace[2122826788] 'agreement among raft nodes before linearized reading' (duration: 137.960483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:20:32.697487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.005519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jjxmx\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-22T06:20:32.697566Z","caller":"traceutil/trace.go:171","msg":"trace[455885783] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jjxmx; range_end:; response_count:1; response_revision:8359; }","duration":"209.344784ms","start":"2026-04-22T06:20:32.488204Z","end":"2026-04-22T06:20:32.697549Z","steps":["trace[455885783] 'agreement among raft nodes before linearized reading' (duration: 207.829773ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:39.091033Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6221} {"level":"info","ts":"2026-04-22T06:20:39.181415Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6221,"took":"88.586302ms","hash":3282340261,"current-db-size-bytes":58728448,"current-db-size":"59 MB","current-db-size-in-use-bytes":23269376,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-22T06:20:39.181477Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3282340261,"revision":6221,"compact-revision":3036} {"level":"info","ts":"2026-04-22T06:20:44.502784Z","caller":"traceutil/trace.go:171","msg":"trace[1670642384] linearizableReadLoop","detail":"{readStateIndex:8759; appliedIndex:8758; }","duration":"121.01388ms","start":"2026-04-22T06:20:44.38174Z","end":"2026-04-22T06:20:44.502753Z","steps":["trace[1670642384] 'read index received' (duration: 120.836085ms)","trace[1670642384] 'applied index is now lower than readState.Index' (duration: 176.214µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:20:44.502917Z","caller":"traceutil/trace.go:171","msg":"trace[1928783161] transaction","detail":"{read_only:false; response_revision:8463; number_of_response:1; }","duration":"159.750829ms","start":"2026-04-22T06:20:44.343154Z","end":"2026-04-22T06:20:44.502904Z","steps":["trace[1928783161] 'process raft request' (duration: 159.44116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:20:44.503099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.352438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:20:44.50314Z","caller":"traceutil/trace.go:171","msg":"trace[748382400] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8463; }","duration":"121.432401ms","start":"2026-04-22T06:20:44.381698Z","end":"2026-04-22T06:20:44.50313Z","steps":["trace[748382400] 'agreement among raft nodes before linearized reading' (duration: 121.347868ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:45.265498Z","caller":"traceutil/trace.go:171","msg":"trace[654509377] transaction","detail":"{read_only:false; response_revision:8472; number_of_response:1; }","duration":"138.928599ms","start":"2026-04-22T06:20:45.126542Z","end":"2026-04-22T06:20:45.265471Z","steps":["trace[654509377] 'process raft request' (duration: 113.485413ms)","trace[654509377] 'compare' (duration: 25.325293ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:20:45.835Z","caller":"traceutil/trace.go:171","msg":"trace[128148462] transaction","detail":"{read_only:false; response_revision:8475; number_of_response:1; }","duration":"106.635297ms","start":"2026-04-22T06:20:45.728337Z","end":"2026-04-22T06:20:45.834972Z","steps":["trace[128148462] 'process raft request' (duration: 106.457682ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:37.294177Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002465.wal"} {"level":"info","ts":"2026-04-22T06:21:46.441463Z","caller":"traceutil/trace.go:171","msg":"trace[1585207712] transaction","detail":"{read_only:false; response_revision:9109; number_of_response:1; }","duration":"128.645968ms","start":"2026-04-22T06:21:46.312779Z","end":"2026-04-22T06:21:46.441425Z","steps":["trace[1585207712] 'process raft request' (duration: 128.288929ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:46.592461Z","caller":"traceutil/trace.go:171","msg":"trace[1176839225] transaction","detail":"{read_only:false; response_revision:9110; number_of_response:1; }","duration":"102.580346ms","start":"2026-04-22T06:21:46.489845Z","end":"2026-04-22T06:21:46.592425Z","steps":["trace[1176839225] 'process raft request' (duration: 71.454454ms)","trace[1176839225] 'compare' (duration: 30.893346ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:23:02.003703Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3ba9ae53cc4335db","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T06:23:02.007652Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-22T06:23:02.007739Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-22T06:25:39.099337Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8397} {"level":"info","ts":"2026-04-22T06:25:39.196034Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8397,"took":"94.328262ms","hash":1091184726,"current-db-size-bytes":58728448,"current-db-size":"59 MB","current-db-size-in-use-bytes":24489984,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-22T06:25:39.196127Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1091184726,"revision":8397,"compact-revision":6221} {"level":"info","ts":"2026-04-22T06:30:39.105422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10743} {"level":"info","ts":"2026-04-22T06:30:39.187735Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10743,"took":"78.660163ms","hash":1177602117,"current-db-size-bytes":58728448,"current-db-size":"59 MB","current-db-size-in-use-bytes":20197376,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-22T06:30:39.187852Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1177602117,"revision":10743,"compact-revision":8397}