{"level":"warn","ts":"2026-05-26T01:25:09.029913Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T01:25:09.030069Z","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-05-26T01:25:09.030205Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T01:25:09.030223Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-05-26T01:25:09.030263Z","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-05-26T01:25:09.034485Z","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-05-26T01:25:09.034729Z","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":8,"max-cpu-available":8,"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-05-26T01:25:09.040743Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.492065ms"} {"level":"info","ts":"2026-05-26T01:25:09.050012Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-05-26T01:25:09.050109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T01:25:09.050137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-05-26T01:25:09.050155Z","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-05-26T01:25:09.05017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-05-26T01:25:09.050215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-05-26T01:25:09.057774Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T01:25:09.059038Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T01:25:09.06024Z","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-05-26T01:25:09.062179Z","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-05-26T01:25:09.066195Z","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-05-26T01:25:09.066639Z","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-05-26T01:25:09.066811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-05-26T01:25:09.066877Z","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-05-26T01:25:09.066961Z","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-05-26T01:25:09.067623Z","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-05-26T01:25:09.068664Z","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-05-26T01:25:09.068838Z","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-05-26T01:25:09.068866Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T01:25:09.068948Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-05-26T01:25:09.06896Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-05-26T01:25:09.450696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T01:25:09.450815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T01:25:09.450844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-05-26T01:25:09.450866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-05-26T01:25:09.450878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-05-26T01:25:09.450895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-05-26T01:25:09.450909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-05-26T01:25:09.452085Z","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-05-26T01:25:09.45241Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T01:25:09.456568Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T01:25:09.456798Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T01:25:09.456836Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T01:25:09.456933Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T01:25:09.458506Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T01:25:09.459954Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-05-26T01:25:09.498741Z","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-05-26T01:25:09.499053Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T01:25:09.499152Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T01:25:18.764533Z","caller":"traceutil/trace.go:171","msg":"trace[552030316] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"182.954737ms","start":"2026-05-26T01:25:18.581554Z","end":"2026-05-26T01:25:18.764508Z","steps":["trace[552030316] 'process raft request' (duration: 182.788065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:25:18.76469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.748433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-26T01:25:18.764774Z","caller":"traceutil/trace.go:171","msg":"trace[1409090004] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:307; }","duration":"141.874315ms","start":"2026-05-26T01:25:18.622881Z","end":"2026-05-26T01:25:18.764756Z","steps":["trace[1409090004] 'agreement among raft nodes before linearized reading' (duration: 141.708662ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:25:18.764516Z","caller":"traceutil/trace.go:171","msg":"trace[918983725] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:318; }","duration":"141.57316ms","start":"2026-05-26T01:25:18.622917Z","end":"2026-05-26T01:25:18.76449Z","steps":["trace[918983725] 'read index received' (duration: 141.400277ms)","trace[918983725] 'applied index is now lower than readState.Index' (duration: 171.733µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:25:26.499317Z","caller":"traceutil/trace.go:171","msg":"trace[1845676833] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"277.25524ms","start":"2026-05-26T01:25:26.222035Z","end":"2026-05-26T01:25:26.49929Z","steps":["trace[1845676833] 'process raft request' (duration: 277.117508ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:25:27.214495Z","caller":"traceutil/trace.go:171","msg":"trace[611638543] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"197.337977ms","start":"2026-05-26T01:25:27.017125Z","end":"2026-05-26T01:25:27.214463Z","steps":["trace[611638543] 'process raft request' (duration: 197.118624ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:25:46.899498Z","caller":"traceutil/trace.go:171","msg":"trace[1769453668] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"248.586783ms","start":"2026-05-26T01:25:46.650873Z","end":"2026-05-26T01:25:46.899459Z","steps":["trace[1769453668] 'read index received' (duration: 248.34713ms)","trace[1769453668] 'applied index is now lower than readState.Index' (duration: 237.843µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:25:46.899772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.788016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:25:46.89986Z","caller":"traceutil/trace.go:171","msg":"trace[865780376] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:491; }","duration":"249.03336ms","start":"2026-05-26T01:25:46.65081Z","end":"2026-05-26T01:25:46.899844Z","steps":["trace[865780376] 'agreement among raft nodes before linearized reading' (duration: 248.798506ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:25:46.899888Z","caller":"traceutil/trace.go:171","msg":"trace[1224380525] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"310.19175ms","start":"2026-05-26T01:25:46.589657Z","end":"2026-05-26T01:25:46.899848Z","steps":["trace[1224380525] 'process raft request' (duration: 309.557161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:25:46.900501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:25:46.589622Z","time spent":"310.349382ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:25:49.514232Z","caller":"traceutil/trace.go:171","msg":"trace[874357916] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"124.002533ms","start":"2026-05-26T01:25:49.390206Z","end":"2026-05-26T01:25:49.514209Z","steps":["trace[874357916] 'process raft request' (duration: 123.495036ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:25:53.909462Z","caller":"traceutil/trace.go:171","msg":"trace[21402411] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"448.996983ms","start":"2026-05-26T01:25:53.460433Z","end":"2026-05-26T01:25:53.90943Z","steps":["trace[21402411] 'process raft request' (duration: 448.77547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:25:53.909652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:25:53.460401Z","time spent":"449.153076ms","remote":"127.0.0.1:38588","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-05-26T01:25:53.915757Z","caller":"traceutil/trace.go:171","msg":"trace[2082874455] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:613; }","duration":"382.836706ms","start":"2026-05-26T01:25:53.5329Z","end":"2026-05-26T01:25:53.915736Z","steps":["trace[2082874455] 'read index received' (duration: 376.280407ms)","trace[2082874455] 'applied index is now lower than readState.Index' (duration: 6.555409ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:25:53.915887Z","caller":"traceutil/trace.go:171","msg":"trace[1916185648] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"400.739241ms","start":"2026-05-26T01:25:53.515136Z","end":"2026-05-26T01:25:53.915875Z","steps":["trace[1916185648] 'process raft request' (duration: 400.496778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:25:53.916028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:25:53.515112Z","time spent":"400.802342ms","remote":"127.0.0.1:38594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T01:25:53.91619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.287232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-26T01:25:53.916275Z","caller":"traceutil/trace.go:171","msg":"trace[2066891715] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"383.376103ms","start":"2026-05-26T01:25:53.532884Z","end":"2026-05-26T01:25:53.91626Z","steps":["trace[2066891715] 'agreement among raft nodes before linearized reading' (duration: 383.047429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:25:53.916324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:25:53.532793Z","time spent":"383.522686ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T01:25:54.690473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.065786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:25:54.690565Z","caller":"traceutil/trace.go:171","msg":"trace[1235385891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"654.216399ms","start":"2026-05-26T01:25:54.036328Z","end":"2026-05-26T01:25:54.690545Z","steps":["trace[1235385891] 'range keys from in-memory index tree' (duration: 653.958655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:25:54.690619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:25:54.036304Z","time spent":"654.30161ms","remote":"127.0.0.1:38428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T01:25:54.700761Z","caller":"traceutil/trace.go:171","msg":"trace[747294855] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"354.366707ms","start":"2026-05-26T01:25:54.346364Z","end":"2026-05-26T01:25:54.700731Z","steps":["trace[747294855] 'process raft request' (duration: 353.495095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:25:54.700918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:25:54.346254Z","time spent":"354.58176ms","remote":"127.0.0.1:38514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:27:04.397157Z","caller":"traceutil/trace.go:171","msg":"trace[1749976204] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"130.95461ms","start":"2026-05-26T01:27:04.266167Z","end":"2026-05-26T01:27:04.397122Z","steps":["trace[1749976204] 'process raft request' (duration: 126.912089ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:27:04.397143Z","caller":"traceutil/trace.go:171","msg":"trace[1900197564] linearizableReadLoop","detail":"{readStateIndex:1482; appliedIndex:1481; }","duration":"127.931893ms","start":"2026-05-26T01:27:04.269168Z","end":"2026-05-26T01:27:04.3971Z","steps":["trace[1900197564] 'read index received' (duration: 122.668847ms)","trace[1900197564] 'applied index is now lower than readState.Index' (duration: 5.261186ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:27:04.398256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.055147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-sp4fk\" ","response":"range_response_count:1 size:4504"} {"level":"info","ts":"2026-05-26T01:27:04.398344Z","caller":"traceutil/trace.go:171","msg":"trace[1941906196] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-patch-sp4fk; range_end:; response_count:1; response_revision:1437; }","duration":"129.207838ms","start":"2026-05-26T01:27:04.2691Z","end":"2026-05-26T01:27:04.398308Z","steps":["trace[1941906196] 'agreement among raft nodes before linearized reading' (duration: 128.127305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:27:30.033647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.032764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T01:27:30.033744Z","caller":"traceutil/trace.go:171","msg":"trace[1367168105] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1929; }","duration":"280.174412ms","start":"2026-05-26T01:27:29.753555Z","end":"2026-05-26T01:27:30.033729Z","steps":["trace[1367168105] 'read index received' (duration: 63.611µs)","trace[1367168105] 'applied index is now lower than readState.Index' (duration: 280.109671ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:27:30.033797Z","caller":"traceutil/trace.go:171","msg":"trace[25423355] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"448.887968ms","start":"2026-05-26T01:27:29.584901Z","end":"2026-05-26T01:27:30.033789Z","steps":["trace[25423355] 'process raft request' (duration: 26.51392ms)","trace[25423355] 'compare' (duration: 421.935993ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:27:30.033838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:27:29.584884Z","time spent":"448.932439ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:27:30.033999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.454915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0afd2978-bd41-4bd7-9a0e-ab5a0fdc9d9b\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-26T01:27:30.03402Z","caller":"traceutil/trace.go:171","msg":"trace[1195365185] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0afd2978-bd41-4bd7-9a0e-ab5a0fdc9d9b; range_end:; response_count:1; response_revision:1858; }","duration":"280.475615ms","start":"2026-05-26T01:27:29.753537Z","end":"2026-05-26T01:27:30.034012Z","steps":["trace[1195365185] 'agreement among raft nodes before linearized reading' (duration: 280.389844ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:27:30.061541Z","caller":"traceutil/trace.go:171","msg":"trace[1862619876] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"189.640936ms","start":"2026-05-26T01:27:29.871847Z","end":"2026-05-26T01:27:30.061488Z","steps":["trace[1862619876] 'process raft request' (duration: 189.371183ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:27:30.085417Z","caller":"traceutil/trace.go:171","msg":"trace[2094910703] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"191.725973ms","start":"2026-05-26T01:27:29.893648Z","end":"2026-05-26T01:27:30.085374Z","steps":["trace[2094910703] 'process raft request' (duration: 191.297868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:27:30.085464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.510228ms","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-05-26T01:27:30.085437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.539404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0afd2978-bd41-4bd7-9a0e-ab5a0fdc9d9b\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-26T01:27:30.085683Z","caller":"traceutil/trace.go:171","msg":"trace[432933042] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0afd2978-bd41-4bd7-9a0e-ab5a0fdc9d9b; range_end:; response_count:1; response_revision:1860; }","duration":"201.835268ms","start":"2026-05-26T01:27:29.883816Z","end":"2026-05-26T01:27:30.085651Z","steps":["trace[432933042] 'agreement among raft nodes before linearized reading' (duration: 201.386402ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:27:30.08556Z","caller":"traceutil/trace.go:171","msg":"trace[964711931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1860; }","duration":"194.659309ms","start":"2026-05-26T01:27:29.890878Z","end":"2026-05-26T01:27:30.085537Z","steps":["trace[964711931] 'agreement among raft nodes before linearized reading' (duration: 194.314485ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:27:37.846742Z","caller":"traceutil/trace.go:171","msg":"trace[1881510118] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"145.968938ms","start":"2026-05-26T01:27:37.700567Z","end":"2026-05-26T01:27:37.846536Z","steps":["trace[1881510118] 'process raft request' (duration: 145.808576ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:27:42.226715Z","caller":"traceutil/trace.go:171","msg":"trace[1663712518] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"124.314387ms","start":"2026-05-26T01:27:42.102379Z","end":"2026-05-26T01:27:42.226693Z","steps":["trace[1663712518] 'process raft request' (duration: 124.123505ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:28:04.391145Z","caller":"traceutil/trace.go:171","msg":"trace[574494897] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"173.016724ms","start":"2026-05-26T01:28:04.218104Z","end":"2026-05-26T01:28:04.391121Z","steps":["trace[574494897] 'process raft request' (duration: 172.863702ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:28:04.481707Z","caller":"traceutil/trace.go:171","msg":"trace[843226893] linearizableReadLoop","detail":"{readStateIndex:2178; appliedIndex:2175; }","duration":"161.103057ms","start":"2026-05-26T01:28:04.320584Z","end":"2026-05-26T01:28:04.481687Z","steps":["trace[843226893] 'read index received' (duration: 70.437924ms)","trace[843226893] 'applied index is now lower than readState.Index' (duration: 90.664163ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:28:04.481839Z","caller":"traceutil/trace.go:171","msg":"trace[1008974957] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"171.077641ms","start":"2026-05-26T01:28:04.310723Z","end":"2026-05-26T01:28:04.481801Z","steps":["trace[1008974957] 'process raft request' (duration: 170.920349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:28:04.481918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.32716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T01:28:04.481971Z","caller":"traceutil/trace.go:171","msg":"trace[327889009] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2099; }","duration":"161.442112ms","start":"2026-05-26T01:28:04.32052Z","end":"2026-05-26T01:28:04.481963Z","steps":["trace[327889009] 'agreement among raft nodes before linearized reading' (duration: 161.29521ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:28:04.481857Z","caller":"traceutil/trace.go:171","msg":"trace[132021328] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"244.551221ms","start":"2026-05-26T01:28:04.237235Z","end":"2026-05-26T01:28:04.481786Z","steps":["trace[132021328] 'process raft request' (duration: 231.34478ms)","trace[132021328] 'compare' (duration: 12.950658ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:28:04.482196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.398984ms","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-05-26T01:28:04.482347Z","caller":"traceutil/trace.go:171","msg":"trace[1880426773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2099; }","duration":"145.637488ms","start":"2026-05-26T01:28:04.336674Z","end":"2026-05-26T01:28:04.482312Z","steps":["trace[1880426773] 'agreement among raft nodes before linearized reading' (duration: 145.228212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:28:04.740971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.801066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-26T01:28:04.741063Z","caller":"traceutil/trace.go:171","msg":"trace[825692726] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2101; }","duration":"108.960407ms","start":"2026-05-26T01:28:04.632081Z","end":"2026-05-26T01:28:04.741042Z","steps":["trace[825692726] 'range keys from in-memory index tree' (duration: 108.561813ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:28:06.595336Z","caller":"traceutil/trace.go:171","msg":"trace[446783738] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"197.772946ms","start":"2026-05-26T01:28:06.397535Z","end":"2026-05-26T01:28:06.595308Z","steps":["trace[446783738] 'process raft request' (duration: 197.572674ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:28:06.599056Z","caller":"traceutil/trace.go:171","msg":"trace[258662376] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"109.420853ms","start":"2026-05-26T01:28:06.489594Z","end":"2026-05-26T01:28:06.599015Z","steps":["trace[258662376] 'process raft request' (duration: 109.316521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:07.110546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.424634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T01:29:07.110832Z","caller":"traceutil/trace.go:171","msg":"trace[848687000] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"179.738683ms","start":"2026-05-26T01:29:06.931023Z","end":"2026-05-26T01:29:07.110761Z","steps":["trace[848687000] 'process raft request' (duration: 11.979595ms)","trace[848687000] 'compare' (duration: 167.040019ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:29:07.111Z","caller":"traceutil/trace.go:171","msg":"trace[252217049] linearizableReadLoop","detail":"{readStateIndex:2574; appliedIndex:2572; }","duration":"158.566295ms","start":"2026-05-26T01:29:06.952404Z","end":"2026-05-26T01:29:07.11097Z","steps":["trace[252217049] 'read index received' (duration: 43.826042ms)","trace[252217049] 'applied index is now lower than readState.Index' (duration: 114.738993ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:29:07.111101Z","caller":"traceutil/trace.go:171","msg":"trace[1878639367] transaction","detail":"{read_only:false; response_revision:2481; number_of_response:1; }","duration":"179.640092ms","start":"2026-05-26T01:29:06.931424Z","end":"2026-05-26T01:29:07.111064Z","steps":["trace[1878639367] 'process raft request' (duration: 179.263427ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:07.11118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.770708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:29:07.111256Z","caller":"traceutil/trace.go:171","msg":"trace[2031596019] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2481; }","duration":"158.90601ms","start":"2026-05-26T01:29:06.952337Z","end":"2026-05-26T01:29:07.111243Z","steps":["trace[2031596019] 'agreement among raft nodes before linearized reading' (duration: 158.786338ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:17.732568Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869647162625897,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T01:29:17.775932Z","caller":"traceutil/trace.go:171","msg":"trace[1164165796] transaction","detail":"{read_only:false; response_revision:2590; number_of_response:1; }","duration":"607.261637ms","start":"2026-05-26T01:29:17.168636Z","end":"2026-05-26T01:29:17.775898Z","steps":["trace[1164165796] 'process raft request' (duration: 606.972145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:17.777201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:17.16861Z","time spent":"607.425233ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:29:17.814575Z","caller":"traceutil/trace.go:171","msg":"trace[210555511] linearizableReadLoop","detail":"{readStateIndex:2688; appliedIndex:2684; }","duration":"582.2249ms","start":"2026-05-26T01:29:17.232255Z","end":"2026-05-26T01:29:17.81448Z","steps":["trace[210555511] 'read index received' (duration: 543.415799ms)","trace[210555511] 'applied index is now lower than readState.Index' (duration: 38.807251ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:29:17.814637Z","caller":"traceutil/trace.go:171","msg":"trace[1328329534] transaction","detail":"{read_only:false; response_revision:2591; number_of_response:1; }","duration":"645.919443ms","start":"2026-05-26T01:29:17.168671Z","end":"2026-05-26T01:29:17.814591Z","steps":["trace[1328329534] 'process raft request' (duration: 645.34247ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:29:17.814612Z","caller":"traceutil/trace.go:171","msg":"trace[71923780] transaction","detail":"{read_only:false; response_revision:2592; number_of_response:1; }","duration":"234.89972ms","start":"2026-05-26T01:29:17.579643Z","end":"2026-05-26T01:29:17.814542Z","steps":["trace[71923780] 'process raft request' (duration: 234.718792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:17.814823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:17.16865Z","time spent":"646.060468ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:29:17.81503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.73167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-05-26T01:29:17.815104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.511146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-26T01:29:17.815106Z","caller":"traceutil/trace.go:171","msg":"trace[2002764170] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2593; }","duration":"582.880026ms","start":"2026-05-26T01:29:17.232202Z","end":"2026-05-26T01:29:17.815082Z","steps":["trace[2002764170] 'agreement among raft nodes before linearized reading' (duration: 582.554223ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:29:17.815155Z","caller":"traceutil/trace.go:171","msg":"trace[1729730509] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2593; }","duration":"509.614559ms","start":"2026-05-26T01:29:17.305525Z","end":"2026-05-26T01:29:17.81514Z","steps":["trace[1729730509] 'agreement among raft nodes before linearized reading' (duration: 509.411011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:17.815193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:17.305493Z","time spent":"509.693372ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T01:29:17.815183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:17.232177Z","time spent":"582.988541ms","remote":"127.0.0.1:38588","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-05-26T01:29:17.815243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.046866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T01:29:17.81531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.950744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-26T01:29:17.815476Z","caller":"traceutil/trace.go:171","msg":"trace[1377866767] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2593; }","duration":"515.212314ms","start":"2026-05-26T01:29:17.30024Z","end":"2026-05-26T01:29:17.815452Z","steps":["trace[1377866767] 'agreement among raft nodes before linearized reading' (duration: 514.587359ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:29:17.815518Z","caller":"traceutil/trace.go:171","msg":"trace[37537765] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:2593; }","duration":"464.460312ms","start":"2026-05-26T01:29:17.350942Z","end":"2026-05-26T01:29:17.815402Z","steps":["trace[37537765] 'agreement among raft nodes before linearized reading' (duration: 463.988513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:17.81554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:17.300214Z","time spent":"515.315048ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T01:29:17.815579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.175213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T01:29:17.815662Z","caller":"traceutil/trace.go:171","msg":"trace[976222393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2593; }","duration":"515.314668ms","start":"2026-05-26T01:29:17.300325Z","end":"2026-05-26T01:29:17.815639Z","steps":["trace[976222393] 'agreement among raft nodes before linearized reading' (duration: 515.050438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:17.815672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.3915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-05-26T01:29:17.81569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:17.350919Z","time spent":"464.710762ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-26T01:29:17.815863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.021204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-26T01:29:17.815823Z","caller":"traceutil/trace.go:171","msg":"trace[1750766809] transaction","detail":"{read_only:false; response_revision:2593; number_of_response:1; }","duration":"225.22234ms","start":"2026-05-26T01:29:17.589575Z","end":"2026-05-26T01:29:17.814798Z","steps":["trace[1750766809] 'process raft request' (duration: 224.840755ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:29:17.815723Z","caller":"traceutil/trace.go:171","msg":"trace[1070099141] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2593; }","duration":"421.462533ms","start":"2026-05-26T01:29:17.394244Z","end":"2026-05-26T01:29:17.815706Z","steps":["trace[1070099141] 'agreement among raft nodes before linearized reading' (duration: 421.345458ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:29:17.815909Z","caller":"traceutil/trace.go:171","msg":"trace[1676382269] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2593; }","duration":"461.152819ms","start":"2026-05-26T01:29:17.354745Z","end":"2026-05-26T01:29:17.815898Z","steps":["trace[1676382269] 'agreement among raft nodes before linearized reading' (duration: 461.029044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:17.815954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:17.394227Z","time spent":"421.717225ms","remote":"127.0.0.1:38592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-05-26T01:29:17.815981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:17.35471Z","time spent":"461.260325ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":551,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-05-26T01:29:17.815723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:17.300294Z","time spent":"515.414132ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T01:29:37.16586Z","caller":"traceutil/trace.go:171","msg":"trace[209725483] transaction","detail":"{read_only:false; response_revision:2703; number_of_response:1; }","duration":"105.690208ms","start":"2026-05-26T01:29:37.060138Z","end":"2026-05-26T01:29:37.165828Z","steps":["trace[209725483] 'process raft request' (duration: 59.145444ms)","trace[209725483] 'compare' (duration: 46.277154ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:29:54.534282Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869647162626445,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T01:29:54.839626Z","caller":"traceutil/trace.go:171","msg":"trace[887935741] transaction","detail":"{read_only:false; response_revision:2792; number_of_response:1; }","duration":"812.380741ms","start":"2026-05-26T01:29:54.027222Z","end":"2026-05-26T01:29:54.839602Z","steps":["trace[887935741] 'process raft request' (duration: 812.180514ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:54.839763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:54.027206Z","time spent":"812.488405ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:29:54.851405Z","caller":"traceutil/trace.go:171","msg":"trace[917274970] linearizableReadLoop","detail":"{readStateIndex:2899; appliedIndex:2895; }","duration":"817.868177ms","start":"2026-05-26T01:29:54.033515Z","end":"2026-05-26T01:29:54.851384Z","steps":["trace[917274970] 'read index received' (duration: 805.87413ms)","trace[917274970] 'applied index is now lower than readState.Index' (duration: 11.992817ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:29:54.851453Z","caller":"traceutil/trace.go:171","msg":"trace[1654955665] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"823.159517ms","start":"2026-05-26T01:29:54.028268Z","end":"2026-05-26T01:29:54.851427Z","steps":["trace[1654955665] 'process raft request' (duration: 823.073044ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:29:54.851475Z","caller":"traceutil/trace.go:171","msg":"trace[2142325243] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"824.185512ms","start":"2026-05-26T01:29:54.027267Z","end":"2026-05-26T01:29:54.851452Z","steps":["trace[2142325243] 'process raft request' (duration: 823.890472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:54.851512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:54.028257Z","time spent":"823.225759ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:29:54.851442Z","caller":"traceutil/trace.go:171","msg":"trace[997284046] transaction","detail":"{read_only:false; response_revision:2794; number_of_response:1; }","duration":"823.469367ms","start":"2026-05-26T01:29:54.027938Z","end":"2026-05-26T01:29:54.851407Z","steps":["trace[997284046] 'process raft request' (duration: 823.355204ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:54.851659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.196403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T01:29:54.851681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.536771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-26T01:29:54.851702Z","caller":"traceutil/trace.go:171","msg":"trace[717993986] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:2795; }","duration":"302.273825ms","start":"2026-05-26T01:29:54.549415Z","end":"2026-05-26T01:29:54.851689Z","steps":["trace[717993986] 'agreement among raft nodes before linearized reading' (duration: 302.214683ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:29:54.85172Z","caller":"traceutil/trace.go:171","msg":"trace[1285820646] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2795; }","duration":"798.594933ms","start":"2026-05-26T01:29:54.053112Z","end":"2026-05-26T01:29:54.851707Z","steps":["trace[1285820646] 'agreement among raft nodes before linearized reading' (duration: 798.48081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:54.85174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:54.549392Z","time spent":"302.340457ms","remote":"127.0.0.1:36990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-05-26T01:29:54.851766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:54.053101Z","time spent":"798.653125ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T01:29:54.851852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:54.027926Z","time spent":"823.688194ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:29:54.851562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.026423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:29:54.851949Z","caller":"traceutil/trace.go:171","msg":"trace[1259047893] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2795; }","duration":"818.446336ms","start":"2026-05-26T01:29:54.033494Z","end":"2026-05-26T01:29:54.85194Z","steps":["trace[1259047893] 'agreement among raft nodes before linearized reading' (duration: 818.023662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:29:54.851985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:54.033486Z","time spent":"818.486647ms","remote":"127.0.0.1:38428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T01:29:54.852649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:29:54.027254Z","time spent":"825.32525ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:33:47.96008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.016753ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-26T01:33:47.960256Z","caller":"traceutil/trace.go:171","msg":"trace[1054567939] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4632; }","duration":"165.16917ms","start":"2026-05-26T01:33:47.795068Z","end":"2026-05-26T01:33:47.960237Z","steps":["trace[1054567939] 'process raft request' (duration: 30.851432ms)","trace[1054567939] 'compare' (duration: 133.555115ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:33:48.167512Z","caller":"traceutil/trace.go:171","msg":"trace[1993717410] linearizableReadLoop","detail":"{readStateIndex:4807; appliedIndex:4806; }","duration":"154.35767ms","start":"2026-05-26T01:33:48.013129Z","end":"2026-05-26T01:33:48.167487Z","steps":["trace[1993717410] 'read index received' (duration: 151.706011ms)","trace[1993717410] 'applied index is now lower than readState.Index' (duration: 2.650399ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:33:48.167707Z","caller":"traceutil/trace.go:171","msg":"trace[693301095] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4633; }","duration":"194.986189ms","start":"2026-05-26T01:33:47.972706Z","end":"2026-05-26T01:33:48.167692Z","steps":["trace[693301095] 'process raft request' (duration: 192.311231ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:48.168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.868589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-05-26T01:33:48.168072Z","caller":"traceutil/trace.go:171","msg":"trace[377536320] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4633; }","duration":"154.992871ms","start":"2026-05-26T01:33:48.013061Z","end":"2026-05-26T01:33:48.168054Z","steps":["trace[377536320] 'agreement among raft nodes before linearized reading' (duration: 154.814888ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:48.169036Z","caller":"traceutil/trace.go:171","msg":"trace[16561702] transaction","detail":"{read_only:false; response_revision:4634; number_of_response:1; }","duration":"132.964471ms","start":"2026-05-26T01:33:48.036061Z","end":"2026-05-26T01:33:48.169026Z","steps":["trace[16561702] 'process raft request' (duration: 132.88783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:48.171687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.068387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9ad4eabe-63ec-455c-bb01-ecf274dff2f0\" ","response":"range_response_count:1 size:4067"} {"level":"info","ts":"2026-05-26T01:33:48.171718Z","caller":"traceutil/trace.go:171","msg":"trace[786754899] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9ad4eabe-63ec-455c-bb01-ecf274dff2f0; range_end:; response_count:1; response_revision:4634; }","duration":"147.146439ms","start":"2026-05-26T01:33:48.024563Z","end":"2026-05-26T01:33:48.17171Z","steps":["trace[786754899] 'agreement among raft nodes before linearized reading' (duration: 147.014127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:48.171961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.997727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:33:48.172034Z","caller":"traceutil/trace.go:171","msg":"trace[664262449] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4634; }","duration":"136.168269ms","start":"2026-05-26T01:33:48.035806Z","end":"2026-05-26T01:33:48.171974Z","steps":["trace[664262449] 'agreement among raft nodes before linearized reading' (duration: 136.140788ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:51.158975Z","caller":"traceutil/trace.go:171","msg":"trace[141679568] linearizableReadLoop","detail":"{readStateIndex:4901; appliedIndex:4900; }","duration":"186.122406ms","start":"2026-05-26T01:33:50.972825Z","end":"2026-05-26T01:33:51.158947Z","steps":["trace[141679568] 'read index received' (duration: 185.991144ms)","trace[141679568] 'applied index is now lower than readState.Index' (duration: 130.442µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:33:51.159016Z","caller":"traceutil/trace.go:171","msg":"trace[386440683] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"189.920675ms","start":"2026-05-26T01:33:50.969073Z","end":"2026-05-26T01:33:51.158994Z","steps":["trace[386440683] 'process raft request' (duration: 189.682571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:51.159148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.309569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-26T01:33:51.159174Z","caller":"traceutil/trace.go:171","msg":"trace[1357778610] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4725; }","duration":"186.400721ms","start":"2026-05-26T01:33:50.972767Z","end":"2026-05-26T01:33:51.159168Z","steps":["trace[1357778610] 'agreement among raft nodes before linearized reading' (duration: 186.284049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:51.173026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.458202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60264"} {"level":"info","ts":"2026-05-26T01:33:51.173129Z","caller":"traceutil/trace.go:171","msg":"trace[1788270586] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4727; }","duration":"197.609394ms","start":"2026-05-26T01:33:50.975507Z","end":"2026-05-26T01:33:51.173116Z","steps":["trace[1788270586] 'agreement among raft nodes before linearized reading' (duration: 197.39866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:51.173307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.843845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207156"} {"level":"info","ts":"2026-05-26T01:33:51.173385Z","caller":"traceutil/trace.go:171","msg":"trace[1012029288] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4727; }","duration":"118.932847ms","start":"2026-05-26T01:33:51.054434Z","end":"2026-05-26T01:33:51.173367Z","steps":["trace[1012029288] 'agreement among raft nodes before linearized reading' (duration: 118.106122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:51.344801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.318288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-05-26T01:33:51.344857Z","caller":"traceutil/trace.go:171","msg":"trace[1311126185] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4727; }","duration":"106.403269ms","start":"2026-05-26T01:33:51.23844Z","end":"2026-05-26T01:33:51.344843Z","steps":["trace[1311126185] 'range keys from in-memory index tree' (duration: 106.209416ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:51.390171Z","caller":"traceutil/trace.go:171","msg":"trace[876485162] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"137.31068ms","start":"2026-05-26T01:33:51.252822Z","end":"2026-05-26T01:33:51.390132Z","steps":["trace[876485162] 'process raft request' (duration: 137.124067ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:54.513527Z","caller":"traceutil/trace.go:171","msg":"trace[121317165] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"150.191333ms","start":"2026-05-26T01:33:54.363296Z","end":"2026-05-26T01:33:54.513487Z","steps":["trace[121317165] 'process raft request' (duration: 72.823256ms)","trace[121317165] 'compare' (duration: 77.156963ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:33:54.514828Z","caller":"traceutil/trace.go:171","msg":"trace[434924370] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"149.198525ms","start":"2026-05-26T01:33:54.365567Z","end":"2026-05-26T01:33:54.514766Z","steps":["trace[434924370] 'process raft request' (duration: 148.752097ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:59.486545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.777849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T01:33:59.486646Z","caller":"traceutil/trace.go:171","msg":"trace[1218875727] linearizableReadLoop","detail":"{readStateIndex:4962; appliedIndex:4961; }","duration":"581.598816ms","start":"2026-05-26T01:33:58.905031Z","end":"2026-05-26T01:33:59.48663Z","steps":["trace[1218875727] 'read index received' (duration: 450.650555ms)","trace[1218875727] 'applied index is now lower than readState.Index' (duration: 130.947161ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:33:59.486715Z","caller":"traceutil/trace.go:171","msg":"trace[492050612] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"582.405071ms","start":"2026-05-26T01:33:58.904299Z","end":"2026-05-26T01:33:59.486704Z","steps":["trace[492050612] 'process raft request' (duration: 451.368777ms)","trace[492050612] 'compare' (duration: 130.664167ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:33:59.486907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:58.904279Z","time spent":"582.468301ms","remote":"127.0.0.1:38580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":991,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:33:59.48727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.229447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12974"} {"level":"info","ts":"2026-05-26T01:33:59.48733Z","caller":"traceutil/trace.go:171","msg":"trace[1198111161] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4783; }","duration":"582.330069ms","start":"2026-05-26T01:33:58.904986Z","end":"2026-05-26T01:33:59.487316Z","steps":["trace[1198111161] 'agreement among raft nodes before linearized reading' (duration: 582.149216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:59.487526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:58.904967Z","time spent":"582.518442ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12996,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-05-26T01:33:59.665544Z","caller":"traceutil/trace.go:171","msg":"trace[1131978273] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"758.553772ms","start":"2026-05-26T01:33:58.906968Z","end":"2026-05-26T01:33:59.665522Z","steps":["trace[1131978273] 'process raft request' (duration: 758.335059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:59.665683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:58.906957Z","time spent":"758.653695ms","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1407,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:33:59.665754Z","caller":"traceutil/trace.go:171","msg":"trace[1253064712] transaction","detail":"{read_only:false; response_revision:4785; number_of_response:1; }","duration":"463.34669ms","start":"2026-05-26T01:33:59.202392Z","end":"2026-05-26T01:33:59.665738Z","steps":["trace[1253064712] 'process raft request' (duration: 463.080505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:59.665846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:59.20237Z","time spent":"463.430592ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:33:59.666017Z","caller":"traceutil/trace.go:171","msg":"trace[870767126] transaction","detail":"{read_only:false; response_revision:4786; number_of_response:1; }","duration":"447.713339ms","start":"2026-05-26T01:33:59.218293Z","end":"2026-05-26T01:33:59.666006Z","steps":["trace[870767126] 'process raft request' (duration: 447.386863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:59.666118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.945231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T01:33:59.666164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:59.218266Z","time spent":"447.786001ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:33:59.666203Z","caller":"traceutil/trace.go:171","msg":"trace[1370524997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4786; }","duration":"630.080554ms","start":"2026-05-26T01:33:59.036095Z","end":"2026-05-26T01:33:59.666175Z","steps":["trace[1370524997] 'agreement among raft nodes before linearized reading' (duration: 629.954722ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:59.665991Z","caller":"traceutil/trace.go:171","msg":"trace[1948471579] linearizableReadLoop","detail":"{readStateIndex:4965; appliedIndex:4962; }","duration":"179.265609ms","start":"2026-05-26T01:33:59.486673Z","end":"2026-05-26T01:33:59.665939Z","steps":["trace[1948471579] 'read index received' (duration: 178.641077ms)","trace[1948471579] 'applied index is now lower than readState.Index' (duration: 622.092µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:33:59.666262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:59.036065Z","time spent":"630.185246ms","remote":"127.0.0.1:38428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T01:33:59.666324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.486869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:33:59.666373Z","caller":"traceutil/trace.go:171","msg":"trace[987097609] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4786; }","duration":"479.601891ms","start":"2026-05-26T01:33:59.186756Z","end":"2026-05-26T01:33:59.666358Z","steps":["trace[987097609] 'agreement among raft nodes before linearized reading' (duration: 479.53507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:59.666416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:59.186733Z","time spent":"479.673093ms","remote":"127.0.0.1:39188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-05-26T01:33:59.701518Z","caller":"traceutil/trace.go:171","msg":"trace[1192366527] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"203.146167ms","start":"2026-05-26T01:33:59.498349Z","end":"2026-05-26T01:33:59.701495Z","steps":["trace[1192366527] 'process raft request' (duration: 202.989174ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.137921Z","caller":"traceutil/trace.go:171","msg":"trace[802054200] linearizableReadLoop","detail":"{readStateIndex:4975; appliedIndex:4974; }","duration":"218.902238ms","start":"2026-05-26T01:33:59.918995Z","end":"2026-05-26T01:34:00.137897Z","steps":["trace[802054200] 'read index received' (duration: 218.569752ms)","trace[802054200] 'applied index is now lower than readState.Index' (duration: 161.363µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:34:00.138363Z","caller":"traceutil/trace.go:171","msg":"trace[394263301] transaction","detail":"{read_only:false; response_revision:4796; number_of_response:1; }","duration":"267.604552ms","start":"2026-05-26T01:33:59.87073Z","end":"2026-05-26T01:34:00.138334Z","steps":["trace[394263301] 'process raft request' (duration: 266.571444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:00.138855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.845304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-26T01:34:00.138917Z","caller":"traceutil/trace.go:171","msg":"trace[2002814974] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4796; }","duration":"219.958977ms","start":"2026-05-26T01:33:59.91894Z","end":"2026-05-26T01:34:00.138899Z","steps":["trace[2002814974] 'agreement among raft nodes before linearized reading' (duration: 219.122732ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.390429Z","caller":"traceutil/trace.go:171","msg":"trace[537876264] transaction","detail":"{read_only:false; response_revision:4797; number_of_response:1; }","duration":"451.133902ms","start":"2026-05-26T01:33:59.939275Z","end":"2026-05-26T01:34:00.390409Z","steps":["trace[537876264] 'process raft request' (duration: 450.969849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:00.39055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:59.939251Z","time spent":"451.235084ms","remote":"127.0.0.1:39188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2797,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:34:00.440703Z","caller":"traceutil/trace.go:171","msg":"trace[936986468] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"296.551929ms","start":"2026-05-26T01:34:00.144128Z","end":"2026-05-26T01:34:00.44068Z","steps":["trace[936986468] 'process raft request' (duration: 296.454817ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.440686Z","caller":"traceutil/trace.go:171","msg":"trace[1812026015] transaction","detail":"{read_only:false; response_revision:4798; number_of_response:1; }","duration":"297.17378ms","start":"2026-05-26T01:34:00.143485Z","end":"2026-05-26T01:34:00.440658Z","steps":["trace[1812026015] 'process raft request' (duration: 296.959596ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.440903Z","caller":"traceutil/trace.go:171","msg":"trace[1818853504] transaction","detail":"{read_only:false; response_revision:4800; number_of_response:1; }","duration":"295.867826ms","start":"2026-05-26T01:34:00.145019Z","end":"2026-05-26T01:34:00.440886Z","steps":["trace[1818853504] 'process raft request' (duration: 295.618072ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.441225Z","caller":"traceutil/trace.go:171","msg":"trace[1405602536] linearizableReadLoop","detail":"{readStateIndex:4978; appliedIndex:4975; }","duration":"296.992687ms","start":"2026-05-26T01:34:00.144206Z","end":"2026-05-26T01:34:00.441199Z","steps":["trace[1405602536] 'read index received' (duration: 246.169215ms)","trace[1405602536] 'applied index is now lower than readState.Index' (duration: 50.822352ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:34:00.441351Z","caller":"traceutil/trace.go:171","msg":"trace[1013284139] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"295.825935ms","start":"2026-05-26T01:34:00.145513Z","end":"2026-05-26T01:34:00.441339Z","steps":["trace[1013284139] 'process raft request' (duration: 295.306226ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:00.441657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.610372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T01:34:00.441698Z","caller":"traceutil/trace.go:171","msg":"trace[727230607] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4802; }","duration":"179.708703ms","start":"2026-05-26T01:34:00.261979Z","end":"2026-05-26T01:34:00.441688Z","steps":["trace[727230607] 'agreement among raft nodes before linearized reading' (duration: 179.569551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:00.44178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.550927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2b11b718-6992-40c3-bc96-83b7e1ed9eaf\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-05-26T01:34:00.441895Z","caller":"traceutil/trace.go:171","msg":"trace[512438663] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2b11b718-6992-40c3-bc96-83b7e1ed9eaf; range_end:; response_count:1; response_revision:4802; }","duration":"297.69334ms","start":"2026-05-26T01:34:00.144182Z","end":"2026-05-26T01:34:00.441876Z","steps":["trace[512438663] 'agreement among raft nodes before linearized reading' (duration: 297.415355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:00.441972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.621215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T01:34:00.442048Z","caller":"traceutil/trace.go:171","msg":"trace[1481455158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4802; }","duration":"163.721447ms","start":"2026-05-26T01:34:00.278311Z","end":"2026-05-26T01:34:00.442032Z","steps":["trace[1481455158] 'agreement among raft nodes before linearized reading' (duration: 163.531194ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.628488Z","caller":"traceutil/trace.go:171","msg":"trace[2037138513] linearizableReadLoop","detail":"{readStateIndex:4985; appliedIndex:4981; }","duration":"180.09641ms","start":"2026-05-26T01:34:00.448375Z","end":"2026-05-26T01:34:00.628471Z","steps":["trace[2037138513] 'read index received' (duration: 6.997045ms)","trace[2037138513] 'applied index is now lower than readState.Index' (duration: 173.098725ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:34:00.628605Z","caller":"traceutil/trace.go:171","msg":"trace[1406344206] transaction","detail":"{read_only:false; response_revision:4804; number_of_response:1; }","duration":"182.008944ms","start":"2026-05-26T01:34:00.446587Z","end":"2026-05-26T01:34:00.628596Z","steps":["trace[1406344206] 'process raft request' (duration: 173.711945ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.628632Z","caller":"traceutil/trace.go:171","msg":"trace[86505800] transaction","detail":"{read_only:false; response_revision:4806; number_of_response:1; }","duration":"181.058406ms","start":"2026-05-26T01:34:00.447563Z","end":"2026-05-26T01:34:00.628621Z","steps":["trace[86505800] 'process raft request' (duration: 180.884483ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.628541Z","caller":"traceutil/trace.go:171","msg":"trace[1580890445] transaction","detail":"{read_only:false; response_revision:4805; number_of_response:1; }","duration":"180.994625ms","start":"2026-05-26T01:34:00.447517Z","end":"2026-05-26T01:34:00.628511Z","steps":["trace[1580890445] 'process raft request' (duration: 180.878253ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:00.629081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.656529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9ad4eabe-63ec-455c-bb01-ecf274dff2f0\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-26T01:34:00.629515Z","caller":"traceutil/trace.go:171","msg":"trace[1099680832] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9ad4eabe-63ec-455c-bb01-ecf274dff2f0; range_end:; response_count:1; response_revision:4806; }","duration":"181.15371ms","start":"2026-05-26T01:34:00.448333Z","end":"2026-05-26T01:34:00.629487Z","steps":["trace[1099680832] 'agreement among raft nodes before linearized reading' (duration: 180.517327ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.629602Z","caller":"traceutil/trace.go:171","msg":"trace[2004337280] transaction","detail":"{read_only:false; response_revision:4807; number_of_response:1; }","duration":"170.407056ms","start":"2026-05-26T01:34:00.45918Z","end":"2026-05-26T01:34:00.629587Z","steps":["trace[2004337280] 'process raft request' (duration: 169.996628ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.62982Z","caller":"traceutil/trace.go:171","msg":"trace[4768132] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"169.598642ms","start":"2026-05-26T01:34:00.46021Z","end":"2026-05-26T01:34:00.629809Z","steps":["trace[4768132] 'process raft request' (duration: 169.038232ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:00.629941Z","caller":"traceutil/trace.go:171","msg":"trace[1560528420] transaction","detail":"{read_only:false; response_revision:4809; number_of_response:1; }","duration":"169.541031ms","start":"2026-05-26T01:34:00.460385Z","end":"2026-05-26T01:34:00.629926Z","steps":["trace[1560528420] 'process raft request' (duration: 168.90274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:00.630695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.393888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:126928"} {"level":"info","ts":"2026-05-26T01:34:00.632425Z","caller":"traceutil/trace.go:171","msg":"trace[822632138] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:4810; }","duration":"172.154998ms","start":"2026-05-26T01:34:00.460254Z","end":"2026-05-26T01:34:00.632409Z","steps":["trace[822632138] 'agreement among raft nodes before linearized reading' (duration: 169.210345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:04.993434Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869647162631557,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T01:34:05.183796Z","caller":"traceutil/trace.go:171","msg":"trace[1734866962] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"729.448397ms","start":"2026-05-26T01:34:04.454324Z","end":"2026-05-26T01:34:05.183772Z","steps":["trace[1734866962] 'process raft request' (duration: 729.264684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.184076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.454303Z","time spent":"729.688322ms","remote":"127.0.0.1:38660","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-05-26T01:34:05.195526Z","caller":"traceutil/trace.go:171","msg":"trace[1259561536] linearizableReadLoop","detail":"{readStateIndex:5073; appliedIndex:5071; }","duration":"702.12008ms","start":"2026-05-26T01:34:04.493381Z","end":"2026-05-26T01:34:05.195502Z","steps":["trace[1259561536] 'read index received' (duration: 690.258538ms)","trace[1259561536] 'applied index is now lower than readState.Index' (duration: 11.860752ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:34:05.195609Z","caller":"traceutil/trace.go:171","msg":"trace[1163180847] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"189.661392ms","start":"2026-05-26T01:34:05.005941Z","end":"2026-05-26T01:34:05.195603Z","steps":["trace[1163180847] 'process raft request' (duration: 189.529319ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:05.195544Z","caller":"traceutil/trace.go:171","msg":"trace[1253910332] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"554.075627ms","start":"2026-05-26T01:34:04.641453Z","end":"2026-05-26T01:34:05.195529Z","steps":["trace[1253910332] 'process raft request' (duration: 553.922414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.195763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.377154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:34:05.195794Z","caller":"traceutil/trace.go:171","msg":"trace[690455017] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:4894; }","duration":"702.451946ms","start":"2026-05-26T01:34:04.493336Z","end":"2026-05-26T01:34:05.195788Z","steps":["trace[690455017] 'agreement among raft nodes before linearized reading' (duration: 702.395335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.195821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.493317Z","time spent":"702.496596ms","remote":"127.0.0.1:38560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-05-26T01:34:05.19589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.641426Z","time spent":"554.305151ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:34:05.196118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.337609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b9d1535e-43b2-4957-ac93-204fdcb01605\" ","response":"range_response_count:1 size:3933"} {"level":"warn","ts":"2026-05-26T01:34:05.196124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.684331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-05-26T01:34:05.196139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.090921ms","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-05-26T01:34:05.196148Z","caller":"traceutil/trace.go:171","msg":"trace[220313241] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b9d1535e-43b2-4957-ac93-204fdcb01605; range_end:; response_count:1; response_revision:4894; }","duration":"374.41008ms","start":"2026-05-26T01:34:04.82173Z","end":"2026-05-26T01:34:05.19614Z","steps":["trace[220313241] 'agreement among raft nodes before linearized reading' (duration: 374.311868ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:05.196157Z","caller":"traceutil/trace.go:171","msg":"trace[1315822988] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4894; }","duration":"390.719241ms","start":"2026-05-26T01:34:04.805427Z","end":"2026-05-26T01:34:05.196146Z","steps":["trace[1315822988] 'agreement among raft nodes before linearized reading' (duration: 390.62292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.196171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.821708Z","time spent":"374.458071ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3955,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b9d1535e-43b2-4957-ac93-204fdcb01605\" "} {"level":"info","ts":"2026-05-26T01:34:05.196173Z","caller":"traceutil/trace.go:171","msg":"trace[1421931024] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4894; }","duration":"543.179053ms","start":"2026-05-26T01:34:04.652984Z","end":"2026-05-26T01:34:05.196163Z","steps":["trace[1421931024] 'agreement among raft nodes before linearized reading' (duration: 543.063991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.196386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.652963Z","time spent":"543.414896ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T01:34:05.196184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.805353Z","time spent":"390.823863ms","remote":"127.0.0.1:39188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3338,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-05-26T01:34:05.196262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.906534ms","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-05-26T01:34:05.196672Z","caller":"traceutil/trace.go:171","msg":"trace[1198491657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4894; }","duration":"549.352582ms","start":"2026-05-26T01:34:04.64731Z","end":"2026-05-26T01:34:05.196663Z","steps":["trace[1198491657] 'agreement among raft nodes before linearized reading' (duration: 548.897894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.196706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.647285Z","time spent":"549.410443ms","remote":"127.0.0.1:38660","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-05-26T01:34:05.196266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.792837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T01:34:05.196901Z","caller":"traceutil/trace.go:171","msg":"trace[1972581244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4894; }","duration":"547.468188ms","start":"2026-05-26T01:34:04.64942Z","end":"2026-05-26T01:34:05.196889Z","steps":["trace[1972581244] 'agreement among raft nodes before linearized reading' (duration: 546.666774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.196938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.649409Z","time spent":"547.517289ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T01:34:05.196328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.26029ms","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-05-26T01:34:05.196991Z","caller":"traceutil/trace.go:171","msg":"trace[74996420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4894; }","duration":"545.923322ms","start":"2026-05-26T01:34:04.651056Z","end":"2026-05-26T01:34:05.19698Z","steps":["trace[74996420] 'agreement among raft nodes before linearized reading' (duration: 545.201989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.197043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.65102Z","time spent":"545.995632ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T01:34:05.197058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.344046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T01:34:05.197111Z","caller":"traceutil/trace.go:171","msg":"trace[857064931] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4894; }","duration":"552.438757ms","start":"2026-05-26T01:34:04.644659Z","end":"2026-05-26T01:34:05.197098Z","steps":["trace[857064931] 'agreement among raft nodes before linearized reading' (duration: 551.700434ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.197142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.644645Z","time spent":"552.491188ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-26T01:34:15.141108Z","caller":"traceutil/trace.go:171","msg":"trace[903517783] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"125.246699ms","start":"2026-05-26T01:34:15.015828Z","end":"2026-05-26T01:34:15.141075Z","steps":["trace[903517783] 'process raft request' (duration: 125.044945ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:15.306015Z","caller":"traceutil/trace.go:171","msg":"trace[860002871] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"179.621127ms","start":"2026-05-26T01:34:15.126376Z","end":"2026-05-26T01:34:15.305997Z","steps":["trace[860002871] 'process raft request' (duration: 137.349172ms)","trace[860002871] 'compare' (duration: 42.124682ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:34:15.30634Z","caller":"traceutil/trace.go:171","msg":"trace[591501741] linearizableReadLoop","detail":"{readStateIndex:5219; appliedIndex:5217; }","duration":"158.724359ms","start":"2026-05-26T01:34:15.147592Z","end":"2026-05-26T01:34:15.306316Z","steps":["trace[591501741] 'read index received' (duration: 116.151479ms)","trace[591501741] 'applied index is now lower than readState.Index' (duration: 42.57232ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:34:15.306361Z","caller":"traceutil/trace.go:171","msg":"trace[2145173992] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"156.346707ms","start":"2026-05-26T01:34:15.149988Z","end":"2026-05-26T01:34:15.306335Z","steps":["trace[2145173992] 'process raft request' (duration: 156.229265ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:15.306389Z","caller":"traceutil/trace.go:171","msg":"trace[733980856] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"158.78131ms","start":"2026-05-26T01:34:15.147566Z","end":"2026-05-26T01:34:15.306347Z","steps":["trace[733980856] 'process raft request' (duration: 158.397133ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:15.306568Z","caller":"traceutil/trace.go:171","msg":"trace[1604360395] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"157.266693ms","start":"2026-05-26T01:34:15.149287Z","end":"2026-05-26T01:34:15.306554Z","steps":["trace[1604360395] 'process raft request' (duration: 156.867546ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:15.306623Z","caller":"traceutil/trace.go:171","msg":"trace[1014641557] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"155.637715ms","start":"2026-05-26T01:34:15.150942Z","end":"2026-05-26T01:34:15.306579Z","steps":["trace[1014641557] 'process raft request' (duration: 155.301629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:15.306869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.239648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13287"} {"level":"info","ts":"2026-05-26T01:34:15.306898Z","caller":"traceutil/trace.go:171","msg":"trace[1127999261] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5038; }","duration":"159.326629ms","start":"2026-05-26T01:34:15.147563Z","end":"2026-05-26T01:34:15.30689Z","steps":["trace[1127999261] 'agreement among raft nodes before linearized reading' (duration: 158.937853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:15.33577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.026565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9ad4eabe-63ec-455c-bb01-ecf274dff2f0\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-26T01:34:15.335893Z","caller":"traceutil/trace.go:171","msg":"trace[1151524075] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9ad4eabe-63ec-455c-bb01-ecf274dff2f0; range_end:; response_count:1; response_revision:5039; }","duration":"188.166608ms","start":"2026-05-26T01:34:15.147708Z","end":"2026-05-26T01:34:15.335875Z","steps":["trace[1151524075] 'agreement among raft nodes before linearized reading' (duration: 187.937704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:15.336184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.594491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-05-26T01:34:15.336358Z","caller":"traceutil/trace.go:171","msg":"trace[2061754968] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5039; }","duration":"118.865685ms","start":"2026-05-26T01:34:15.217477Z","end":"2026-05-26T01:34:15.336342Z","steps":["trace[2061754968] 'agreement among raft nodes before linearized reading' (duration: 118.654632ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:15.500144Z","caller":"traceutil/trace.go:171","msg":"trace[1421477006] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"159.087116ms","start":"2026-05-26T01:34:15.34103Z","end":"2026-05-26T01:34:15.500117Z","steps":["trace[1421477006] 'process raft request' (duration: 86.560917ms)","trace[1421477006] 'compare' (duration: 72.340926ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:34:15.500627Z","caller":"traceutil/trace.go:171","msg":"trace[1484420812] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"159.406731ms","start":"2026-05-26T01:34:15.341179Z","end":"2026-05-26T01:34:15.500586Z","steps":["trace[1484420812] 'process raft request' (duration: 158.901602ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:15.500652Z","caller":"traceutil/trace.go:171","msg":"trace[1778799031] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"158.477004ms","start":"2026-05-26T01:34:15.342144Z","end":"2026-05-26T01:34:15.500621Z","steps":["trace[1778799031] 'process raft request' (duration: 158.200079ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:15.50065Z","caller":"traceutil/trace.go:171","msg":"trace[196798608] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"157.112891ms","start":"2026-05-26T01:34:15.343511Z","end":"2026-05-26T01:34:15.500624Z","steps":["trace[196798608] 'process raft request' (duration: 156.877707ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:15.500665Z","caller":"traceutil/trace.go:171","msg":"trace[1307385729] transaction","detail":"{read_only:false; response_revision:5043; number_of_response:1; }","duration":"158.586666ms","start":"2026-05-26T01:34:15.342055Z","end":"2026-05-26T01:34:15.500642Z","steps":["trace[1307385729] 'process raft request' (duration: 158.22215ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:52.006545Z","caller":"traceutil/trace.go:171","msg":"trace[400689923] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"232.178436ms","start":"2026-05-26T01:34:51.774336Z","end":"2026-05-26T01:34:52.006515Z","steps":["trace[400689923] 'process raft request' (duration: 231.985503ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:35:09.519993Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2873} {"level":"info","ts":"2026-05-26T01:35:09.604794Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2873,"took":"83.215358ms","hash":3018923922,"current-db-size-bytes":53825536,"current-db-size":"54 MB","current-db-size-in-use-bytes":28827648,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-26T01:35:09.604862Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3018923922,"revision":2873,"compact-revision":-1} {"level":"warn","ts":"2026-05-26T01:37:48.844616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.730909ms","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-05-26T01:37:48.844723Z","caller":"traceutil/trace.go:171","msg":"trace[847627771] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6597; }","duration":"212.902856ms","start":"2026-05-26T01:37:48.631799Z","end":"2026-05-26T01:37:48.844702Z","steps":["trace[847627771] 'range keys from in-memory index tree' (duration: 212.512872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:48.845057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.246845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T01:37:48.845096Z","caller":"traceutil/trace.go:171","msg":"trace[1201116697] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6597; }","duration":"226.352718ms","start":"2026-05-26T01:37:48.618733Z","end":"2026-05-26T01:37:48.845086Z","steps":["trace[1201116697] 'range keys from in-memory index tree' (duration: 226.112991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:48.845268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.378477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T01:37:48.845302Z","caller":"traceutil/trace.go:171","msg":"trace[536521283] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6597; }","duration":"225.411858ms","start":"2026-05-26T01:37:48.619881Z","end":"2026-05-26T01:37:48.845293Z","steps":["trace[536521283] 'range keys from in-memory index tree' (duration: 225.255913ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:48.845447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.473793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T01:37:48.845652Z","caller":"traceutil/trace.go:171","msg":"trace[1764305157] transaction","detail":"{read_only:false; response_revision:6598; number_of_response:1; }","duration":"196.824018ms","start":"2026-05-26T01:37:48.648809Z","end":"2026-05-26T01:37:48.845633Z","steps":["trace[1764305157] 'compare' (duration: 193.764391ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:48.845804Z","caller":"traceutil/trace.go:171","msg":"trace[790773448] linearizableReadLoop","detail":"{readStateIndex:6835; appliedIndex:6833; }","duration":"163.910721ms","start":"2026-05-26T01:37:48.681869Z","end":"2026-05-26T01:37:48.84578Z","steps":["trace[790773448] 'read index received' (duration: 45.142µs)","trace[790773448] 'applied index is now lower than readState.Index' (duration: 163.864299ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:37:48.846003Z","caller":"traceutil/trace.go:171","msg":"trace[1306943205] transaction","detail":"{read_only:false; response_revision:6599; number_of_response:1; }","duration":"183.17991ms","start":"2026-05-26T01:37:48.662809Z","end":"2026-05-26T01:37:48.845989Z","steps":["trace[1306943205] 'process raft request' (duration: 182.746686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:48.846019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.148638ms","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-05-26T01:37:48.846067Z","caller":"traceutil/trace.go:171","msg":"trace[418477868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6599; }","duration":"164.237321ms","start":"2026-05-26T01:37:48.681817Z","end":"2026-05-26T01:37:48.846054Z","steps":["trace[418477868] 'agreement among raft nodes before linearized reading' (duration: 164.049195ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:48.954194Z","caller":"traceutil/trace.go:171","msg":"trace[1049839630] transaction","detail":"{read_only:false; response_revision:6600; number_of_response:1; }","duration":"104.221542ms","start":"2026-05-26T01:37:48.849945Z","end":"2026-05-26T01:37:48.954166Z","steps":["trace[1049839630] 'process raft request' (duration: 102.488776ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:49.090532Z","caller":"traceutil/trace.go:171","msg":"trace[1584124127] linearizableReadLoop","detail":"{readStateIndex:6839; appliedIndex:6835; }","duration":"230.224508ms","start":"2026-05-26T01:37:48.860289Z","end":"2026-05-26T01:37:49.090513Z","steps":["trace[1584124127] 'read index received' (duration: 92.150693ms)","trace[1584124127] 'applied index is now lower than readState.Index' (duration: 138.072855ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:37:49.090951Z","caller":"traceutil/trace.go:171","msg":"trace[1619837180] transaction","detail":"{read_only:false; response_revision:6601; number_of_response:1; }","duration":"239.618819ms","start":"2026-05-26T01:37:48.851307Z","end":"2026-05-26T01:37:49.090925Z","steps":["trace[1619837180] 'process raft request' (duration: 236.343364ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:49.090925Z","caller":"traceutil/trace.go:171","msg":"trace[1595944017] transaction","detail":"{read_only:false; response_revision:6602; number_of_response:1; }","duration":"239.33691ms","start":"2026-05-26T01:37:48.851524Z","end":"2026-05-26T01:37:49.09086Z","steps":["trace[1595944017] 'process raft request' (duration: 238.918137ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:49.091023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.701744ms","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-05-26T01:37:49.091111Z","caller":"traceutil/trace.go:171","msg":"trace[88898763] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6603; }","duration":"230.824518ms","start":"2026-05-26T01:37:48.860258Z","end":"2026-05-26T01:37:49.091083Z","steps":["trace[88898763] 'agreement among raft nodes before linearized reading' (duration: 230.491426ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:49.091194Z","caller":"traceutil/trace.go:171","msg":"trace[544809579] transaction","detail":"{read_only:false; response_revision:6603; number_of_response:1; }","duration":"238.763343ms","start":"2026-05-26T01:37:48.85239Z","end":"2026-05-26T01:37:49.091153Z","steps":["trace[544809579] 'process raft request' (duration: 238.093141ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:52.53241Z","caller":"traceutil/trace.go:171","msg":"trace[1594208230] transaction","detail":"{read_only:false; response_revision:6615; number_of_response:1; }","duration":"217.026167ms","start":"2026-05-26T01:37:52.315337Z","end":"2026-05-26T01:37:52.532363Z","steps":["trace[1594208230] 'process raft request' (duration: 216.104288ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:53.001885Z","caller":"traceutil/trace.go:171","msg":"trace[1358047863] transaction","detail":"{read_only:false; response_revision:6616; number_of_response:1; }","duration":"685.344085ms","start":"2026-05-26T01:37:52.316508Z","end":"2026-05-26T01:37:53.001852Z","steps":["trace[1358047863] 'process raft request' (duration: 683.774135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:53.002064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:37:52.316493Z","time spent":"685.4775ms","remote":"127.0.0.1:38660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:37:53.002203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.726128ms","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-05-26T01:37:53.00225Z","caller":"traceutil/trace.go:171","msg":"trace[1623728737] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:6616; }","duration":"498.819391ms","start":"2026-05-26T01:37:52.503409Z","end":"2026-05-26T01:37:53.002228Z","steps":["trace[1623728737] 'agreement among raft nodes before linearized reading' (duration: 498.604914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:53.002274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:37:52.50337Z","time spent":"498.899255ms","remote":"127.0.0.1:38452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"info","ts":"2026-05-26T01:37:53.002675Z","caller":"traceutil/trace.go:171","msg":"trace[1207157188] transaction","detail":"{read_only:false; response_revision:6617; number_of_response:1; }","duration":"144.41942ms","start":"2026-05-26T01:37:52.858239Z","end":"2026-05-26T01:37:53.002659Z","steps":["trace[1207157188] 'process raft request' (duration: 144.272445ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:53.003239Z","caller":"traceutil/trace.go:171","msg":"trace[149346861] transaction","detail":"{read_only:false; response_revision:6618; number_of_response:1; }","duration":"143.844481ms","start":"2026-05-26T01:37:52.85936Z","end":"2026-05-26T01:37:53.003204Z","steps":["trace[149346861] 'process raft request' (duration: 143.252122ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:53.001319Z","caller":"traceutil/trace.go:171","msg":"trace[1601273542] linearizableReadLoop","detail":"{readStateIndex:6852; appliedIndex:6850; }","duration":"497.808509ms","start":"2026-05-26T01:37:52.503489Z","end":"2026-05-26T01:37:53.001297Z","steps":["trace[1601273542] 'read index received' (duration: 28.016534ms)","trace[1601273542] 'applied index is now lower than readState.Index' (duration: 469.786755ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:37:53.003473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.771119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:37:53.003504Z","caller":"traceutil/trace.go:171","msg":"trace[1451652374] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:6618; }","duration":"289.871991ms","start":"2026-05-26T01:37:52.713623Z","end":"2026-05-26T01:37:53.003495Z","steps":["trace[1451652374] 'agreement among raft nodes before linearized reading' (duration: 289.769508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:53.355946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.626042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-26T01:37:53.356021Z","caller":"traceutil/trace.go:171","msg":"trace[795007366] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6620; }","duration":"243.755126ms","start":"2026-05-26T01:37:53.112252Z","end":"2026-05-26T01:37:53.356007Z","steps":["trace[795007366] 'range keys from in-memory index tree' (duration: 243.465517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:53.356034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.780497ms","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-05-26T01:37:53.356034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.387699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T01:37:53.356064Z","caller":"traceutil/trace.go:171","msg":"trace[2030916094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6620; }","duration":"248.858639ms","start":"2026-05-26T01:37:53.107196Z","end":"2026-05-26T01:37:53.356055Z","steps":["trace[2030916094] 'range keys from in-memory index tree' (duration: 248.645162ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:53.356066Z","caller":"traceutil/trace.go:171","msg":"trace[705897349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6620; }","duration":"251.474922ms","start":"2026-05-26T01:37:53.104582Z","end":"2026-05-26T01:37:53.356057Z","steps":["trace[705897349] 'range keys from in-memory index tree' (duration: 251.185653ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:53.356128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.909088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T01:37:53.356197Z","caller":"traceutil/trace.go:171","msg":"trace[1726350237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6620; }","duration":"248.044193ms","start":"2026-05-26T01:37:53.108138Z","end":"2026-05-26T01:37:53.356182Z","steps":["trace[1726350237] 'range keys from in-memory index tree' (duration: 247.702661ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:57.518183Z","caller":"traceutil/trace.go:171","msg":"trace[964415440] transaction","detail":"{read_only:false; response_revision:6643; number_of_response:1; }","duration":"133.604936ms","start":"2026-05-26T01:37:57.384557Z","end":"2026-05-26T01:37:57.518162Z","steps":["trace[964415440] 'process raft request' (duration: 133.555465ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:57.518284Z","caller":"traceutil/trace.go:171","msg":"trace[1510282592] transaction","detail":"{read_only:false; response_revision:6642; number_of_response:1; }","duration":"133.831044ms","start":"2026-05-26T01:37:57.384418Z","end":"2026-05-26T01:37:57.518249Z","steps":["trace[1510282592] 'process raft request' (duration: 133.554905ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:38:02.041671Z","caller":"traceutil/trace.go:171","msg":"trace[1452602305] transaction","detail":"{read_only:false; response_revision:6670; number_of_response:1; }","duration":"135.536284ms","start":"2026-05-26T01:38:01.906116Z","end":"2026-05-26T01:38:02.041653Z","steps":["trace[1452602305] 'process raft request' (duration: 135.253905ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:38:02.688813Z","caller":"traceutil/trace.go:171","msg":"trace[198937773] transaction","detail":"{read_only:false; response_revision:6671; number_of_response:1; }","duration":"118.815494ms","start":"2026-05-26T01:38:02.569973Z","end":"2026-05-26T01:38:02.688789Z","steps":["trace[198937773] 'process raft request' (duration: 118.640509ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:40:09.528197Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5510} {"level":"info","ts":"2026-05-26T01:40:09.656753Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5510,"took":"127.198889ms","hash":866469126,"current-db-size-bytes":53825536,"current-db-size":"54 MB","current-db-size-in-use-bytes":18444288,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-26T01:40:09.656809Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":866469126,"revision":5510,"compact-revision":2873}