{"level":"warn","ts":"2026-05-27T06:02:35.870212Z","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-27T06:02:35.870456Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.39: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.19.213.39:2380","--initial-cluster=instance=https://199.19.213.39:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.39:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.39: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-27T06:02:35.870569Z","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-27T06:02:35.870609Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.39:2380"]} {"level":"info","ts":"2026-05-27T06:02:35.870647Z","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-27T06:02:35.871325Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.39:2379"]} {"level":"info","ts":"2026-05-27T06:02:35.87145Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.39:2380"],"listen-peer-urls":["https://199.19.213.39:2380"],"advertise-client-urls":["https://199.19.213.39:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.39:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.39: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-27T06:02:35.875733Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.008907ms"} {"level":"info","ts":"2026-05-27T06:02:35.883196Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"95026ee9c61f87d3","cluster-id":"98e25849a4b355e0"} {"level":"info","ts":"2026-05-27T06:02:35.883414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T06:02:35.883493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 became follower at term 0"} {"level":"info","ts":"2026-05-27T06:02:35.883548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 95026ee9c61f87d3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T06:02:35.883602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 became follower at term 1"} {"level":"info","ts":"2026-05-27T06:02:35.883753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 switched to configuration voters=(10737266411935074259)"} {"level":"warn","ts":"2026-05-27T06:02:35.893742Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T06:02:35.896913Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T06:02:35.89898Z","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-27T06:02:35.901802Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"95026ee9c61f87d3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T06:02:35.90271Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"95026ee9c61f87d3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T06:02:35.902834Z","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-27T06:02:35.903012Z","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-27T06:02:35.903063Z","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-27T06:02:35.904076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 switched to configuration voters=(10737266411935074259)"} {"level":"info","ts":"2026-05-27T06:02:35.90421Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"98e25849a4b355e0","local-member-id":"95026ee9c61f87d3","added-peer-id":"95026ee9c61f87d3","added-peer-peer-urls":["https://199.19.213.39:2380"]} {"level":"info","ts":"2026-05-27T06:02:35.906761Z","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-27T06:02:35.906973Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"95026ee9c61f87d3","initial-advertise-peer-urls":["https://199.19.213.39:2380"],"listen-peer-urls":["https://199.19.213.39:2380"],"advertise-client-urls":["https://199.19.213.39:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.39:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T06:02:35.907007Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T06:02:35.907111Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.39:2380"} {"level":"info","ts":"2026-05-27T06:02:35.907128Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.39:2380"} {"level":"info","ts":"2026-05-27T06:02:36.084668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T06:02:36.084713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T06:02:36.084729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 received MsgPreVoteResp from 95026ee9c61f87d3 at term 1"} {"level":"info","ts":"2026-05-27T06:02:36.084744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 became candidate at term 2"} {"level":"info","ts":"2026-05-27T06:02:36.084751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 received MsgVoteResp from 95026ee9c61f87d3 at term 2"} {"level":"info","ts":"2026-05-27T06:02:36.084763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95026ee9c61f87d3 became leader at term 2"} {"level":"info","ts":"2026-05-27T06:02:36.084772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 95026ee9c61f87d3 elected leader 95026ee9c61f87d3 at term 2"} {"level":"info","ts":"2026-05-27T06:02:36.085921Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T06:02:36.088819Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"98e25849a4b355e0","local-member-id":"95026ee9c61f87d3","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T06:02:36.088924Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"95026ee9c61f87d3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.39:2379]}","request-path":"/0/members/95026ee9c61f87d3/attributes","cluster-id":"98e25849a4b355e0","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T06:02:36.088932Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T06:02:36.088988Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T06:02:36.08925Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T06:02:36.089304Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T06:02:36.089884Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T06:02:36.089972Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T06:02:36.096916Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T06:02:36.099095Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.39:2379"} {"level":"info","ts":"2026-05-27T06:02:54.574233Z","caller":"traceutil/trace.go:171","msg":"trace[1267473382] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"152.990009ms","start":"2026-05-27T06:02:54.42122Z","end":"2026-05-27T06:02:54.57421Z","steps":["trace[1267473382] 'process raft request' (duration: 152.873635ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:03:18.970299Z","caller":"traceutil/trace.go:171","msg":"trace[385110063] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"169.085598ms","start":"2026-05-27T06:03:18.801177Z","end":"2026-05-27T06:03:18.970262Z","steps":["trace[385110063] 'process raft request' (duration: 168.398988ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:03:19.594324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.506776ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T06:03:19.594621Z","caller":"traceutil/trace.go:171","msg":"trace[1603276665] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"325.724992ms","start":"2026-05-27T06:03:19.268822Z","end":"2026-05-27T06:03:19.594547Z","steps":["trace[1603276665] 'process raft request' (duration: 201.240167ms)","trace[1603276665] 'compare' (duration: 123.26268ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:03:19.59474Z","caller":"traceutil/trace.go:171","msg":"trace[1412254041] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"263.182715ms","start":"2026-05-27T06:03:19.331517Z","end":"2026-05-27T06:03:19.5947Z","steps":["trace[1412254041] 'read index received' (duration: 138.623809ms)","trace[1412254041] 'applied index is now lower than readState.Index' (duration: 124.555506ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:03:19.594881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:03:19.268789Z","time spent":"325.953399ms","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:03:19.595055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.471004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2wmg7\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-27T06:03:19.595172Z","caller":"traceutil/trace.go:171","msg":"trace[2109496086] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2wmg7; range_end:; response_count:1; response_revision:591; }","duration":"263.67166ms","start":"2026-05-27T06:03:19.331468Z","end":"2026-05-27T06:03:19.59514Z","steps":["trace[2109496086] 'agreement among raft nodes before linearized reading' (duration: 263.3328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:03:19.59638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.01657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:03:19.596465Z","caller":"traceutil/trace.go:171","msg":"trace[1994297716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"189.143244ms","start":"2026-05-27T06:03:19.407299Z","end":"2026-05-27T06:03:19.596442Z","steps":["trace[1994297716] 'agreement among raft nodes before linearized reading' (duration: 188.975039ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:15.198573Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839017992,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T06:04:15.238691Z","caller":"traceutil/trace.go:171","msg":"trace[1925278929] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"558.36372ms","start":"2026-05-27T06:04:14.680306Z","end":"2026-05-27T06:04:15.23867Z","steps":["trace[1925278929] 'process raft request' (duration: 558.247126ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:15.238832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:14.680279Z","time spent":"558.469793ms","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T06:04:15.241324Z","caller":"traceutil/trace.go:171","msg":"trace[177035252] linearizableReadLoop","detail":"{readStateIndex:1281; appliedIndex:1280; }","duration":"543.183779ms","start":"2026-05-27T06:04:14.698128Z","end":"2026-05-27T06:04:15.241311Z","steps":["trace[177035252] 'read index received' (duration: 540.556159ms)","trace[177035252] 'applied index is now lower than readState.Index' (duration: 2.6269ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:04:15.241489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.353984ms","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-27T06:04:15.241522Z","caller":"traceutil/trace.go:171","msg":"trace[1458444708] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1240; }","duration":"543.434276ms","start":"2026-05-27T06:04:14.698079Z","end":"2026-05-27T06:04:15.241514Z","steps":["trace[1458444708] 'agreement among raft nodes before linearized reading' (duration: 543.313732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:15.241547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:14.698061Z","time spent":"543.478828ms","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T06:04:15.241545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.293789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:04:15.241605Z","caller":"traceutil/trace.go:171","msg":"trace[501712191] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1240; }","duration":"382.425522ms","start":"2026-05-27T06:04:14.859167Z","end":"2026-05-27T06:04:15.241592Z","steps":["trace[501712191] 'agreement among raft nodes before linearized reading' (duration: 382.284528ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:15.241688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:14.859146Z","time spent":"382.487485ms","remote":"127.0.0.1:48410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:04:15.24169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.040439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-27T06:04:15.241781Z","caller":"traceutil/trace.go:171","msg":"trace[186005651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1240; }","duration":"147.161992ms","start":"2026-05-27T06:04:15.094596Z","end":"2026-05-27T06:04:15.241758Z","steps":["trace[186005651] 'agreement among raft nodes before linearized reading' (duration: 146.883624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:15.242198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.375661ms","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-27T06:04:15.242417Z","caller":"traceutil/trace.go:171","msg":"trace[1140403975] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1240; }","duration":"152.67697ms","start":"2026-05-27T06:04:15.089717Z","end":"2026-05-27T06:04:15.242394Z","steps":["trace[1140403975] 'agreement among raft nodes before linearized reading' (duration: 151.977649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:16.717061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.627721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T06:04:16.717186Z","caller":"traceutil/trace.go:171","msg":"trace[1281997550] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1248; }","duration":"385.810397ms","start":"2026-05-27T06:04:16.331352Z","end":"2026-05-27T06:04:16.717162Z","steps":["trace[1281997550] 'count revisions from in-memory index tree' (duration: 385.549469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:16.717245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:16.33133Z","time spent":"385.897319ms","remote":"127.0.0.1:48652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":19,"response size":31,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:04:16.717539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.616499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:04:16.717638Z","caller":"traceutil/trace.go:171","msg":"trace[1100708898] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1248; }","duration":"330.775624ms","start":"2026-05-27T06:04:16.386839Z","end":"2026-05-27T06:04:16.717615Z","steps":["trace[1100708898] 'count revisions from in-memory index tree' (duration: 330.552586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:16.717689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:16.386818Z","time spent":"330.856796ms","remote":"127.0.0.1:48716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":29,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-05-27T06:05:07.675688Z","caller":"traceutil/trace.go:171","msg":"trace[1432454071] linearizableReadLoop","detail":"{readStateIndex:2024; appliedIndex:2023; }","duration":"150.432836ms","start":"2026-05-27T06:05:07.525224Z","end":"2026-05-27T06:05:07.675657Z","steps":["trace[1432454071] 'read index received' (duration: 125.342109ms)","trace[1432454071] 'applied index is now lower than readState.Index' (duration: 25.089217ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:05:07.675731Z","caller":"traceutil/trace.go:171","msg":"trace[987786230] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"152.094974ms","start":"2026-05-27T06:05:07.523592Z","end":"2026-05-27T06:05:07.675687Z","steps":["trace[987786230] 'process raft request' (duration: 126.995637ms)","trace[987786230] 'compare' (duration: 24.561181ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:05:07.675895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.654222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-27T06:05:07.676002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.355917ms","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-27T06:05:07.676047Z","caller":"traceutil/trace.go:171","msg":"trace[750438377] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1950; }","duration":"148.458661ms","start":"2026-05-27T06:05:07.527578Z","end":"2026-05-27T06:05:07.676036Z","steps":["trace[750438377] 'agreement among raft nodes before linearized reading' (duration: 148.251505ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:05:07.676043Z","caller":"traceutil/trace.go:171","msg":"trace[1578644002] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1950; }","duration":"150.816057ms","start":"2026-05-27T06:05:07.525172Z","end":"2026-05-27T06:05:07.675988Z","steps":["trace[1578644002] 'agreement among raft nodes before linearized reading' (duration: 150.58007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:05:07.67621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.680254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-27T06:05:07.67625Z","caller":"traceutil/trace.go:171","msg":"trace[1374032376] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1950; }","duration":"108.746676ms","start":"2026-05-27T06:05:07.567492Z","end":"2026-05-27T06:05:07.676239Z","steps":["trace[1374032376] 'agreement among raft nodes before linearized reading' (duration: 108.654063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:05:07.676358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.614025ms","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-27T06:05:07.676449Z","caller":"traceutil/trace.go:171","msg":"trace[199639423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1950; }","duration":"148.746429ms","start":"2026-05-27T06:05:07.527683Z","end":"2026-05-27T06:05:07.676429Z","steps":["trace[199639423] 'agreement among raft nodes before linearized reading' (duration: 148.520872ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:07:06.358341Z","caller":"traceutil/trace.go:171","msg":"trace[1444775854] transaction","detail":"{read_only:false; response_revision:2790; number_of_response:1; }","duration":"114.252939ms","start":"2026-05-27T06:07:06.244057Z","end":"2026-05-27T06:07:06.35831Z","steps":["trace[1444775854] 'process raft request' (duration: 114.089394ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:45.42598Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839022996,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:08:45.926977Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839022996,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:08:46.382743Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.652667697s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T06:08:46.383471Z","caller":"traceutil/trace.go:171","msg":"trace[93752907] linearizableReadLoop","detail":"{readStateIndex:3443; appliedIndex:3442; }","duration":"1.457849021s","start":"2026-05-27T06:08:44.925591Z","end":"2026-05-27T06:08:46.38344Z","steps":["trace[93752907] 'read index received' (duration: 1.457673056s)","trace[93752907] 'applied index is now lower than readState.Index' (duration: 174.795µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:08:46.383557Z","caller":"traceutil/trace.go:171","msg":"trace[607062185] transaction","detail":"{read_only:false; response_revision:3315; number_of_response:1; }","duration":"1.653614854s","start":"2026-05-27T06:08:44.729915Z","end":"2026-05-27T06:08:46.38353Z","steps":["trace[607062185] 'process raft request' (duration: 1.653354977s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.383791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:44.729883Z","time spent":"1.653736677s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:08:46.383831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.458217422s","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-27T06:08:46.3839Z","caller":"traceutil/trace.go:171","msg":"trace[546560155] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3315; }","duration":"1.458335035s","start":"2026-05-27T06:08:44.925541Z","end":"2026-05-27T06:08:46.383876Z","steps":["trace[546560155] 'agreement among raft nodes before linearized reading' (duration: 1.458086408s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.383986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:44.925524Z","time spent":"1.458452437s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-27T06:08:46.412322Z","caller":"traceutil/trace.go:171","msg":"trace[1534735248] transaction","detail":"{read_only:false; response_revision:3317; number_of_response:1; }","duration":"308.498237ms","start":"2026-05-27T06:08:46.103796Z","end":"2026-05-27T06:08:46.412294Z","steps":["trace[1534735248] 'process raft request' (duration: 308.405454ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:08:46.412418Z","caller":"traceutil/trace.go:171","msg":"trace[1616337327] transaction","detail":"{read_only:false; response_revision:3316; number_of_response:1; }","duration":"315.323455ms","start":"2026-05-27T06:08:46.09704Z","end":"2026-05-27T06:08:46.412364Z","steps":["trace[1616337327] 'process raft request' (duration: 299.775487ms)","trace[1616337327] 'compare' (duration: 15.243799ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:08:46.412498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:46.103772Z","time spent":"308.63449ms","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T06:08:46.412568Z","caller":"traceutil/trace.go:171","msg":"trace[190563992] transaction","detail":"{read_only:false; response_revision:3318; number_of_response:1; }","duration":"118.237465ms","start":"2026-05-27T06:08:46.294299Z","end":"2026-05-27T06:08:46.412536Z","steps":["trace[190563992] 'process raft request' (duration: 117.956708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.412883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.481294634s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-27T06:08:46.412711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:46.097014Z","time spent":"315.486298ms","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:08:46.412744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003911922s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:08:46.412937Z","caller":"traceutil/trace.go:171","msg":"trace[109415195] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3319; }","duration":"1.481353417s","start":"2026-05-27T06:08:44.931567Z","end":"2026-05-27T06:08:46.41292Z","steps":["trace[109415195] 'agreement among raft nodes before linearized reading' (duration: 1.481207903s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:08:46.413014Z","caller":"traceutil/trace.go:171","msg":"trace[1785180394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3319; }","duration":"1.00418649s","start":"2026-05-27T06:08:45.408777Z","end":"2026-05-27T06:08:46.412964Z","steps":["trace[1785180394] 'agreement among raft nodes before linearized reading' (duration: 1.003906802s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.412941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.481312086s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-27T06:08:46.413062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:45.408756Z","time spent":"1.004291233s","remote":"127.0.0.1:48322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T06:08:46.413067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:44.931563Z","time spent":"1.48149035s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T06:08:46.412769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.480878173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-27T06:08:46.413023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.464235707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:08:46.413087Z","caller":"traceutil/trace.go:171","msg":"trace[1211363801] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3319; }","duration":"1.481475119s","start":"2026-05-27T06:08:44.931586Z","end":"2026-05-27T06:08:46.413061Z","steps":["trace[1211363801] 'agreement among raft nodes before linearized reading' (duration: 1.481171231s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:08:46.41314Z","caller":"traceutil/trace.go:171","msg":"trace[35033564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3319; }","duration":"1.481289894s","start":"2026-05-27T06:08:44.931832Z","end":"2026-05-27T06:08:46.413121Z","steps":["trace[35033564] 'agreement among raft nodes before linearized reading' (duration: 1.480810921s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.413168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:44.931576Z","time spent":"1.481578562s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-27T06:08:46.413172Z","caller":"traceutil/trace.go:171","msg":"trace[1794211290] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:3319; }","duration":"1.464465883s","start":"2026-05-27T06:08:44.948675Z","end":"2026-05-27T06:08:46.413141Z","steps":["trace[1794211290] 'agreement among raft nodes before linearized reading' (duration: 1.464156954s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.413192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:44.931809Z","time spent":"1.481370917s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T06:08:46.412818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.091297342s","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-27T06:08:46.413236Z","caller":"traceutil/trace.go:171","msg":"trace[802522428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3319; }","duration":"1.091743854s","start":"2026-05-27T06:08:45.321482Z","end":"2026-05-27T06:08:46.413226Z","steps":["trace[802522428] 'agreement among raft nodes before linearized reading' (duration: 1.091294102s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.413231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:44.948664Z","time spent":"1.464552545s","remote":"127.0.0.1:44208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:08:46.412819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.295640719s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:08:46.41326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:45.321463Z","time spent":"1.091789506s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T06:08:46.412786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.268282618s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-05-27T06:08:46.413306Z","caller":"traceutil/trace.go:171","msg":"trace[927795986] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:3319; }","duration":"1.296167184s","start":"2026-05-27T06:08:45.117123Z","end":"2026-05-27T06:08:46.41329Z","steps":["trace[927795986] 'agreement among raft nodes before linearized reading' (duration: 1.29566599s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:08:46.413327Z","caller":"traceutil/trace.go:171","msg":"trace[1789530490] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3319; }","duration":"1.268845824s","start":"2026-05-27T06:08:45.144464Z","end":"2026-05-27T06:08:46.413309Z","steps":["trace[1789530490] 'agreement among raft nodes before linearized reading' (duration: 1.268158706s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.412818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.643698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:08:46.412787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.481197162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-05-27T06:08:46.413359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:45.117098Z","time spent":"1.296244435s","remote":"127.0.0.1:48454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:08:46.413371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:45.144451Z","time spent":"1.268908545s","remote":"127.0.0.1:48510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-05-27T06:08:46.413383Z","caller":"traceutil/trace.go:171","msg":"trace[224137534] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:3319; }","duration":"721.257095ms","start":"2026-05-27T06:08:45.692116Z","end":"2026-05-27T06:08:46.413373Z","steps":["trace[224137534] 'agreement among raft nodes before linearized reading' (duration: 720.669949ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.413406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:45.692096Z","time spent":"721.300426ms","remote":"127.0.0.1:50768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-05-27T06:08:46.413418Z","caller":"traceutil/trace.go:171","msg":"trace[1081434533] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3319; }","duration":"1.481843129s","start":"2026-05-27T06:08:44.93154Z","end":"2026-05-27T06:08:46.413383Z","steps":["trace[1081434533] 'agreement among raft nodes before linearized reading' (duration: 1.481072558s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.412815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.92297ms","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-27T06:08:46.413453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:44.931533Z","time spent":"1.481910932s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-05-27T06:08:46.413498Z","caller":"traceutil/trace.go:171","msg":"trace[168577688] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3319; }","duration":"778.663641ms","start":"2026-05-27T06:08:45.634812Z","end":"2026-05-27T06:08:46.413476Z","steps":["trace[168577688] 'agreement among raft nodes before linearized reading' (duration: 777.824378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:08:46.413549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:08:45.634791Z","time spent":"778.744192ms","remote":"127.0.0.1:48524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1393,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-05-27T06:09:19.778893Z","caller":"traceutil/trace.go:171","msg":"trace[1753225482] linearizableReadLoop","detail":"{readStateIndex:3824; appliedIndex:3823; }","duration":"133.938266ms","start":"2026-05-27T06:09:19.644923Z","end":"2026-05-27T06:09:19.778861Z","steps":["trace[1753225482] 'read index received' (duration: 133.694269ms)","trace[1753225482] 'applied index is now lower than readState.Index' (duration: 243.117µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:09:19.779121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.190383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.39\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-27T06:09:19.779166Z","caller":"traceutil/trace.go:171","msg":"trace[404624815] range","detail":"{range_begin:/registry/masterleases/199.19.213.39; range_end:; response_count:1; response_revision:3684; }","duration":"134.280295ms","start":"2026-05-27T06:09:19.644872Z","end":"2026-05-27T06:09:19.779152Z","steps":["trace[404624815] 'agreement among raft nodes before linearized reading' (duration: 134.10234ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:19.779032Z","caller":"traceutil/trace.go:171","msg":"trace[2023652627] transaction","detail":"{read_only:false; response_revision:3684; number_of_response:1; }","duration":"308.864987ms","start":"2026-05-27T06:09:19.470106Z","end":"2026-05-27T06:09:19.778971Z","steps":["trace[2023652627] 'process raft request' (duration: 308.60716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:19.780125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:19.470088Z","time spent":"309.287099ms","remote":"127.0.0.1:48418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4387,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T06:09:21.036266Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:21.537359Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:22.038478Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:22.539641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:22.766234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000970864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-27T06:09:22.766362Z","caller":"traceutil/trace.go:171","msg":"trace[758571072] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001129498s","start":"2026-05-27T06:09:20.765198Z","end":"2026-05-27T06:09:22.766327Z","steps":["trace[758571072] 'agreement among raft nodes before linearized reading' (duration: 2.000974833s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:22.766442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.765191Z","time spent":"2.00123152s","remote":"127.0.0.1:48322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/27 06:09:22 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:23.040691Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:23.40924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.0004357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:23.409327Z","caller":"traceutil/trace.go:171","msg":"trace[2039341264] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000577614s","start":"2026-05-27T06:09:21.408731Z","end":"2026-05-27T06:09:23.409308Z","steps":["trace[2039341264] 'agreement among raft nodes before linearized reading' (duration: 2.000476431s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:23.409373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:21.408681Z","time spent":"2.000681186s","remote":"127.0.0.1:48332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/27 06:09:23 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:23.541175Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:24.042271Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:24.542789Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:25.043142Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:25.416691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999819482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-27T06:09:25.416789Z","caller":"traceutil/trace.go:171","msg":"trace[952295311] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999972056s","start":"2026-05-27T06:09:23.416797Z","end":"2026-05-27T06:09:25.416769Z","steps":["trace[952295311] 'agreement among raft nodes before linearized reading' (duration: 1.999844183s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:25.416834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:23.416783Z","time spent":"2.000041148s","remote":"127.0.0.1:48322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T06:09:25.543818Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:25.582094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.583339Z","time spent":"4.998746632s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-27T06:09:25.586695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.588438Z","time spent":"4.998250658s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/05/27 06:09:25 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:25.622054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998978477s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:25.622126Z","caller":"traceutil/trace.go:171","msg":"trace[1033219891] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.99906345s","start":"2026-05-27T06:09:20.623045Z","end":"2026-05-27T06:09:25.622109Z","steps":["trace[1033219891] 'agreement among raft nodes before linearized reading' (duration: 4.998976897s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:25.622169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.622959Z","time spent":"4.999200874s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/05/27 06:09:25 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:25.752439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999169184s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-27T06:09:25.752593Z","caller":"traceutil/trace.go:171","msg":"trace[1541020977] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999511013s","start":"2026-05-27T06:09:20.753054Z","end":"2026-05-27T06:09:25.752565Z","steps":["trace[1541020977] 'agreement among raft nodes before linearized reading' (duration: 4.999210225s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:25.752669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.753031Z","time spent":"4.999619616s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T06:09:25.758695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999098501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:25.758754Z","caller":"traceutil/trace.go:171","msg":"trace[1092050859] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999188494s","start":"2026-05-27T06:09:20.759552Z","end":"2026-05-27T06:09:25.75874Z","steps":["trace[1092050859] 'agreement among raft nodes before linearized reading' (duration: 4.999125662s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:25.758842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.759532Z","time spent":"4.999298496s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/05/27 06:09:25 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:26.044896Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:26.545341Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:27.046029Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:27.417211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999844223s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-27T06:09:27.417296Z","caller":"traceutil/trace.go:171","msg":"trace[1444897372] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999973115s","start":"2026-05-27T06:09:25.417305Z","end":"2026-05-27T06:09:27.417279Z","steps":["trace[1444897372] 'agreement among raft nodes before linearized reading' (duration: 1.999871233s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:27.417338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:25.417288Z","time spent":"2.000040058s","remote":"127.0.0.1:48332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T06:09:27.480733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.480237Z","time spent":"7.000493307s","remote":"127.0.0.1:45922","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-27T06:09:27.536914Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-05-27T06:09:27.537169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.001321489s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-27T06:09:27.537224Z","caller":"traceutil/trace.go:171","msg":"trace[2137031422] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; }","duration":"7.001437572s","start":"2026-05-27T06:09:20.535766Z","end":"2026-05-27T06:09:27.537203Z","steps":["trace[2137031422] 'agreement among raft nodes before linearized reading' (duration: 7.001352139s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:27.537277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.535749Z","time spent":"7.001515714s","remote":"127.0.0.1:48818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":0,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:27.5765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.576048Z","time spent":"7.000448655s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-27T06:09:28.037607Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:28.538683Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:29.039249Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:29.42515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000366856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-27T06:09:29.425247Z","caller":"traceutil/trace.go:171","msg":"trace[849649795] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00050826s","start":"2026-05-27T06:09:27.424713Z","end":"2026-05-27T06:09:29.425221Z","steps":["trace[849649795] 'agreement among raft nodes before linearized reading' (duration: 2.000389307s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:29.425303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:27.424702Z","time spent":"2.000589492s","remote":"127.0.0.1:48322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/27 06:09:29 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:29.540266Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:30.041377Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:30.412914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:23.412732Z","time spent":"7.000175168s","remote":"127.0.0.1:48394","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-27T06:09:30.542516Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:30.575113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.994706295s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:30.575209Z","caller":"traceutil/trace.go:171","msg":"trace[129383865] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; }","duration":"2.994818629s","start":"2026-05-27T06:09:27.58037Z","end":"2026-05-27T06:09:30.575189Z","steps":["trace[129383865] 'agreement among raft nodes before linearized reading' (duration: 2.994703264s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:30.575268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:27.580316Z","time spent":"2.994935201s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":0,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} 2026/05/27 06:09:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:30.582374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998496875s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:30.582467Z","caller":"traceutil/trace.go:171","msg":"trace[1725816125] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; }","duration":"4.998665009s","start":"2026-05-27T06:09:25.583783Z","end":"2026-05-27T06:09:30.582448Z","steps":["trace[1725816125] 'agreement among raft nodes before linearized reading' (duration: 4.998547416s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:30.582611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:25.583764Z","time spent":"4.998835244s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":0,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} 2026/05/27 06:09:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:30.587041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998699931s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:30.5871Z","caller":"traceutil/trace.go:171","msg":"trace[1205988023] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; }","duration":"4.998807465s","start":"2026-05-27T06:09:25.588277Z","end":"2026-05-27T06:09:30.587085Z","steps":["trace[1205988023] 'agreement among raft nodes before linearized reading' (duration: 4.998741433s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:30.587132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:25.588253Z","time spent":"4.998872296s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":0,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} 2026/05/27 06:09:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:30.621244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.354247757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:30.621309Z","caller":"traceutil/trace.go:171","msg":"trace[1894572884] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; }","duration":"8.35435012s","start":"2026-05-27T06:09:22.266944Z","end":"2026-05-27T06:09:30.621294Z","steps":["trace[1894572884] 'agreement among raft nodes before linearized reading' (duration: 8.354272788s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:30.621343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:22.266927Z","time spent":"8.354408741s","remote":"127.0.0.1:48510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":0,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} 2026/05/27 06:09:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:30.622294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.997819619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:30.622383Z","caller":"traceutil/trace.go:171","msg":"trace[1927249017] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.997951633s","start":"2026-05-27T06:09:27.624412Z","end":"2026-05-27T06:09:30.622363Z","steps":["trace[1927249017] 'agreement among raft nodes before linearized reading' (duration: 2.99783755s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:30.622431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:27.624401Z","time spent":"2.998020375s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/05/27 06:09:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:30.64487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.000076514s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:30.645002Z","caller":"traceutil/trace.go:171","msg":"trace[340475071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"10.000272109s","start":"2026-05-27T06:09:20.644704Z","end":"2026-05-27T06:09:30.644976Z","steps":["trace[340475071] 'agreement among raft nodes before linearized reading' (duration: 10.000088154s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:30.64506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.644688Z","time spent":"10.000361062s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} 2026/05/27 06:09:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:30.75232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.997599704s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:30.752443Z","caller":"traceutil/trace.go:171","msg":"trace[1173551531] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.997781689s","start":"2026-05-27T06:09:27.75464Z","end":"2026-05-27T06:09:30.752422Z","steps":["trace[1173551531] 'agreement among raft nodes before linearized reading' (duration: 2.997632895s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:30.752496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:27.754618Z","time spent":"2.997867011s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/05/27 06:09:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:30.759093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999542419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"","error":"context canceled"} {"level":"warn","ts":"2026-05-27T06:09:30.759097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.998791145s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:30.759151Z","caller":"traceutil/trace.go:171","msg":"trace[228282079] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; }","duration":"9.999635212s","start":"2026-05-27T06:09:20.759501Z","end":"2026-05-27T06:09:30.759137Z","steps":["trace[228282079] 'agreement among raft nodes before linearized reading' (duration: 9.99956907s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:30.759165Z","caller":"traceutil/trace.go:171","msg":"trace[910841751] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.998889418s","start":"2026-05-27T06:09:27.760258Z","end":"2026-05-27T06:09:30.759148Z","steps":["trace[910841751] 'agreement among raft nodes before linearized reading' (duration: 2.998819636s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:30.759188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.759484Z","time spent":"9.999695183s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":0,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} 2026/05/27 06:09:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:30.759244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:27.760243Z","time spent":"2.998984701s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/05/27 06:09:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:30.760091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.000123526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:30.760142Z","caller":"traceutil/trace.go:171","msg":"trace[980184086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"10.000213119s","start":"2026-05-27T06:09:20.759916Z","end":"2026-05-27T06:09:30.760129Z","steps":["trace[980184086] 'agreement among raft nodes before linearized reading' (duration: 10.000157617s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:30.760177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.75991Z","time spent":"10.00025917s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} 2026/05/27 06:09:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:30.96358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:23.963465Z","time spent":"7.000110885s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-27T06:09:31.043439Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:31.425604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000041767s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:31.425709Z","caller":"traceutil/trace.go:171","msg":"trace[276890961] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000191731s","start":"2026-05-27T06:09:29.425489Z","end":"2026-05-27T06:09:31.42568Z","steps":["trace[276890961] 'agreement among raft nodes before linearized reading' (duration: 2.000075318s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:31.42578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:29.425469Z","time spent":"2.000297124s","remote":"127.0.0.1:48332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/27 06:09:31 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:31.439465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00016616s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:31.439549Z","caller":"traceutil/trace.go:171","msg":"trace[436225305] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000265753s","start":"2026-05-27T06:09:29.439265Z","end":"2026-05-27T06:09:31.43953Z","steps":["trace[436225305] 'agreement among raft nodes before linearized reading' (duration: 2.00016381s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:31.439594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:29.4392Z","time spent":"2.000385067s","remote":"127.0.0.1:48322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/27 06:09:31 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:31.544468Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:31.694845Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"07d39e6807180c2c","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-05-27T06:09:32.045323Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:32.546422Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:33.047249Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9787340584839023826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T06:09:33.294431Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"12.814033458s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-27T06:09:33.434866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000192072s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-27T06:09:33.434982Z","caller":"traceutil/trace.go:171","msg":"trace[1478544111] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000352446s","start":"2026-05-27T06:09:31.43461Z","end":"2026-05-27T06:09:33.434963Z","steps":["trace[1478544111] 'agreement among raft nodes before linearized reading' (duration: 2.000208862s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.435033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:31.434594Z","time spent":"2.000427919s","remote":"127.0.0.1:48322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/27 06:09:33 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T06:09:33.557404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.414733ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T06:09:33.657979Z","caller":"traceutil/trace.go:171","msg":"trace[1727366436] transaction","detail":"{read_only:false; response_revision:3692; number_of_response:1; }","duration":"6.140134295s","start":"2026-05-27T06:09:27.517815Z","end":"2026-05-27T06:09:33.657949Z","steps":["trace[1727366436] 'process raft request' (duration: 6.13994505s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.658155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:27.517798Z","time spent":"6.140268099s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:09:33.804526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.487039ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T06:09:33.804783Z","caller":"traceutil/trace.go:171","msg":"trace[2147307034] transaction","detail":"{read_only:false; response_revision:3693; number_of_response:1; }","duration":"4.548930936s","start":"2026-05-27T06:09:29.255812Z","end":"2026-05-27T06:09:33.804742Z","steps":["trace[2147307034] 'process raft request' (duration: 4.402118758s)","trace[2147307034] 'compare' (duration: 146.290354ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:09:33.804857Z","caller":"traceutil/trace.go:171","msg":"trace[1611451812] transaction","detail":"{read_only:false; response_revision:3696; number_of_response:1; }","duration":"3.158058637s","start":"2026-05-27T06:09:30.646776Z","end":"2026-05-27T06:09:33.804835Z","steps":["trace[1611451812] 'process raft request' (duration: 3.157985635s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:33.804846Z","caller":"traceutil/trace.go:171","msg":"trace[393856312] transaction","detail":"{read_only:false; response_revision:3694; number_of_response:1; }","duration":"3.219155394s","start":"2026-05-27T06:09:30.585628Z","end":"2026-05-27T06:09:33.804783Z","steps":["trace[393856312] 'process raft request' (duration: 3.21900718s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:33.804864Z","caller":"traceutil/trace.go:171","msg":"trace[1100125609] transaction","detail":"{read_only:false; response_revision:3695; number_of_response:1; }","duration":"3.178843278s","start":"2026-05-27T06:09:30.625982Z","end":"2026-05-27T06:09:33.804825Z","steps":["trace[1100125609] 'process raft request' (duration: 3.178723374s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.804938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:30.646749Z","time spent":"3.15815148s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:09:33.804981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:30.585604Z","time spent":"3.219304308s","remote":"127.0.0.1:48394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T06:09:33.804983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:29.255789Z","time spent":"4.549097781s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T06:09:33.805016Z","caller":"traceutil/trace.go:171","msg":"trace[345556137] transaction","detail":"{read_only:false; response_revision:3697; number_of_response:1; }","duration":"3.043095482s","start":"2026-05-27T06:09:30.761905Z","end":"2026-05-27T06:09:33.805Z","steps":["trace[345556137] 'process raft request' (duration: 3.042889277s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.805064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:30.761882Z","time spent":"3.043157134s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:09:33.80508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:30.625948Z","time spent":"3.179014882s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:09:33.805435Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"100.403µs","request":"header: lease_revoke:","response":"size:29","error":"lease not found"} {"level":"info","ts":"2026-05-27T06:09:33.805506Z","caller":"traceutil/trace.go:171","msg":"trace[1857404230] linearizableReadLoop","detail":"{readStateIndex:3841; appliedIndex:3826; }","duration":"6.268415837s","start":"2026-05-27T06:09:27.537079Z","end":"2026-05-27T06:09:33.805494Z","steps":["trace[1857404230] 'read index received' (duration: 5.757566856s)","trace[1857404230] 'applied index is now lower than readState.Index' (duration: 510.847961ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:09:33.805627Z","caller":"traceutil/trace.go:171","msg":"trace[1704070711] transaction","detail":"{read_only:false; response_revision:3698; number_of_response:1; }","duration":"3.042143277s","start":"2026-05-27T06:09:30.76346Z","end":"2026-05-27T06:09:33.805603Z","steps":["trace[1704070711] 'process raft request' (duration: 3.041485588s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.80565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.471293843s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:09:33.805663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.146725786s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-27T06:09:33.805701Z","caller":"traceutil/trace.go:171","msg":"trace[1864158774] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:3698; }","duration":"12.471365245s","start":"2026-05-27T06:09:21.334318Z","end":"2026-05-27T06:09:33.805683Z","steps":["trace[1864158774] 'agreement among raft nodes before linearized reading' (duration: 12.471281022s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.805721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:30.763445Z","time spent":"3.042226498s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":411,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:09:33.805747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.513928512s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"warn","ts":"2026-05-27T06:09:33.805757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:21.334301Z","time spent":"12.471434627s","remote":"127.0.0.1:46282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"info","ts":"2026-05-27T06:09:33.805783Z","caller":"traceutil/trace.go:171","msg":"trace[947621104] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:3698; }","duration":"12.514005895s","start":"2026-05-27T06:09:21.291768Z","end":"2026-05-27T06:09:33.805774Z","steps":["trace[947621104] 'agreement among raft nodes before linearized reading' (duration: 12.513920103s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.805804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.419078891s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-05-27T06:09:33.80582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:21.291746Z","time spent":"12.514066866s","remote":"127.0.0.1:48492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1657,"request content":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" "} {"level":"warn","ts":"2026-05-27T06:09:33.80574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.011611358s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:09:33.805991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.151735894s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:09:33.805946Z","caller":"traceutil/trace.go:171","msg":"trace[1391466084] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:3698; }","duration":"9.011897426s","start":"2026-05-27T06:09:24.794009Z","end":"2026-05-27T06:09:33.805906Z","steps":["trace[1391466084] 'agreement among raft nodes before linearized reading' (duration: 9.011552106s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.80609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.375337234s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-27T06:09:33.806121Z","caller":"traceutil/trace.go:171","msg":"trace[264178074] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:3698; }","duration":"7.375378575s","start":"2026-05-27T06:09:26.430735Z","end":"2026-05-27T06:09:33.806113Z","steps":["trace[264178074] 'agreement among raft nodes before linearized reading' (duration: 7.375272413s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.806138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.267756731s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-72v5t\" ","response":"range_response_count:1 size:6526"} {"level":"warn","ts":"2026-05-27T06:09:33.806154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:26.430671Z","time spent":"7.375476147s","remote":"127.0.0.1:48846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":357,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.80616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.827326984s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:09:33.806123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:24.793986Z","time spent":"9.012112722s","remote":"127.0.0.1:44054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-05-27T06:09:33.806184Z","caller":"traceutil/trace.go:171","msg":"trace[1162632244] range","detail":"{range_begin:/registry/pods/openstack/keepalived-72v5t; range_end:; response_count:1; response_revision:3698; }","duration":"13.267841833s","start":"2026-05-27T06:09:20.53833Z","end":"2026-05-27T06:09:33.806171Z","steps":["trace[1162632244] 'agreement among raft nodes before linearized reading' (duration: 13.267706639s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.806218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.282930964s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-27T06:09:33.806172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.86969517s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-05-27T06:09:33.806238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:20.538311Z","time spent":"13.267914984s","remote":"127.0.0.1:48510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6550,"request content":"key:\"/registry/pods/openstack/keepalived-72v5t\" "} {"level":"info","ts":"2026-05-27T06:09:33.806253Z","caller":"traceutil/trace.go:171","msg":"trace[1666931253] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:3698; }","duration":"12.283001136s","start":"2026-05-27T06:09:21.523244Z","end":"2026-05-27T06:09:33.806245Z","steps":["trace[1666931253] 'agreement among raft nodes before linearized reading' (duration: 12.282950735s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:33.806257Z","caller":"traceutil/trace.go:171","msg":"trace[115725350] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:3698; }","duration":"10.869817783s","start":"2026-05-27T06:09:22.936431Z","end":"2026-05-27T06:09:33.806249Z","steps":["trace[115725350] 'agreement among raft nodes before linearized reading' (duration: 10.869646408s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.806283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:21.523225Z","time spent":"12.283050747s","remote":"127.0.0.1:48486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":2,"response size":31,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.805867Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"07d39e6807180c2c","error":"lease not found"} {"level":"info","ts":"2026-05-27T06:09:33.805848Z","caller":"traceutil/trace.go:171","msg":"trace[1295100809] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:3698; }","duration":"6.419125012s","start":"2026-05-27T06:09:27.38671Z","end":"2026-05-27T06:09:33.805835Z","steps":["trace[1295100809] 'agreement among raft nodes before linearized reading' (duration: 6.418805463s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:33.806271Z","caller":"traceutil/trace.go:171","msg":"trace[1002041783] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:3698; }","duration":"9.146778068s","start":"2026-05-27T06:09:24.658906Z","end":"2026-05-27T06:09:33.805684Z","steps":["trace[1002041783] 'agreement among raft nodes before linearized reading' (duration: 9.146663475s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.806331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:27.386674Z","time spent":"6.419649516s","remote":"127.0.0.1:48394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":357,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.806332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.317550963s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:09:33.806368Z","caller":"traceutil/trace.go:171","msg":"trace[1558900732] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:3698; }","duration":"12.317626076s","start":"2026-05-27T06:09:21.488734Z","end":"2026-05-27T06:09:33.80636Z","steps":["trace[1558900732] 'agreement among raft nodes before linearized reading' (duration: 12.317570175s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.806365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:24.658892Z","time spent":"9.147450176s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-05-27T06:09:33.806392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:21.488708Z","time spent":"12.317676527s","remote":"127.0.0.1:48572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.806449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.044746747s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:09:33.806222Z","caller":"traceutil/trace.go:171","msg":"trace[141439363] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:3698; }","duration":"6.827443467s","start":"2026-05-27T06:09:26.978763Z","end":"2026-05-27T06:09:33.806207Z","steps":["trace[141439363] 'agreement among raft nodes before linearized reading' (duration: 6.827344314s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.80648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.894592843s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:09:33.806486Z","caller":"traceutil/trace.go:171","msg":"trace[2007633792] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:3698; }","duration":"6.044798959s","start":"2026-05-27T06:09:27.761677Z","end":"2026-05-27T06:09:33.806475Z","steps":["trace[2007633792] 'agreement among raft nodes before linearized reading' (duration: 6.044736338s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:33.806501Z","caller":"traceutil/trace.go:171","msg":"trace[774581433] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:3698; }","duration":"7.894647215s","start":"2026-05-27T06:09:25.911847Z","end":"2026-05-27T06:09:33.806495Z","steps":["trace[774581433] 'agreement among raft nodes before linearized reading' (duration: 7.894612574s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.806499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:26.978743Z","time spent":"6.827744996s","remote":"127.0.0.1:44254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.806515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:27.761669Z","time spent":"6.04483761s","remote":"127.0.0.1:50782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.806522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:25.911828Z","time spent":"7.894688166s","remote":"127.0.0.1:50792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.806291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:22.936409Z","time spent":"10.869872285s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-05-27T06:09:33.806675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.754477581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:09:33.806684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.666865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret\" ","response":"range_response_count:1 size:811"} {"level":"warn","ts":"2026-05-27T06:09:33.806675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.377513877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7102"} {"level":"info","ts":"2026-05-27T06:09:33.806715Z","caller":"traceutil/trace.go:171","msg":"trace[251573819] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret; range_end:; response_count:1; response_revision:3698; }","duration":"506.717426ms","start":"2026-05-27T06:09:33.299987Z","end":"2026-05-27T06:09:33.806704Z","steps":["trace[251573819] 'agreement among raft nodes before linearized reading' (duration: 506.625804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.806738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:33.299875Z","time spent":"506.857ms","remote":"127.0.0.1:45922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":835,"request content":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret\" "} {"level":"info","ts":"2026-05-27T06:09:33.806735Z","caller":"traceutil/trace.go:171","msg":"trace[2127159865] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:3698; }","duration":"2.37760654s","start":"2026-05-27T06:09:31.429115Z","end":"2026-05-27T06:09:33.806722Z","steps":["trace[2127159865] 'agreement among raft nodes before linearized reading' (duration: 2.377472896s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.806772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:31.429097Z","time spent":"2.377662992s","remote":"127.0.0.1:48510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7126,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-05-27T06:09:33.806799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.84003802s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-27T06:09:33.806828Z","caller":"traceutil/trace.go:171","msg":"trace[1886777273] range","detail":"{range_begin:/registry/leases/ingress-nginx/ingress-nginx-leader; range_end:; response_count:1; response_revision:3698; }","duration":"2.840107142s","start":"2026-05-27T06:09:30.96671Z","end":"2026-05-27T06:09:33.806818Z","steps":["trace[1886777273] 'agreement among raft nodes before linearized reading' (duration: 2.8400055s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.806856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:30.966688Z","time spent":"2.840162313s","remote":"127.0.0.1:48592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":514,"request content":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" "} {"level":"warn","ts":"2026-05-27T06:09:33.80696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.610888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:09:33.806984Z","caller":"traceutil/trace.go:171","msg":"trace[435537119] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3698; }","duration":"371.685851ms","start":"2026-05-27T06:09:33.435291Z","end":"2026-05-27T06:09:33.806977Z","steps":["trace[435537119] 'agreement among raft nodes before linearized reading' (duration: 371.64797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.806977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.324935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:09:33.807002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:33.43526Z","time spent":"371.736642ms","remote":"127.0.0.1:48332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T06:09:33.807032Z","caller":"traceutil/trace.go:171","msg":"trace[1428694834] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret; range_end:; response_count:0; response_revision:3698; }","duration":"514.403076ms","start":"2026-05-27T06:09:33.292599Z","end":"2026-05-27T06:09:33.807002Z","steps":["trace[1428694834] 'agreement among raft nodes before linearized reading' (duration: 514.344185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.80706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.96139092s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"warn","ts":"2026-05-27T06:09:33.807072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:33.292578Z","time spent":"514.482789ms","remote":"127.0.0.1:45922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" "} {"level":"info","ts":"2026-05-27T06:09:33.807087Z","caller":"traceutil/trace.go:171","msg":"trace[2002837030] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:3698; }","duration":"2.961456362s","start":"2026-05-27T06:09:30.845622Z","end":"2026-05-27T06:09:33.807079Z","steps":["trace[2002837030] 'agreement among raft nodes before linearized reading' (duration: 2.961360649s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:33.806036Z","caller":"traceutil/trace.go:171","msg":"trace[2131855223] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:3698; }","duration":"9.151854577s","start":"2026-05-27T06:09:24.65417Z","end":"2026-05-27T06:09:33.806024Z","steps":["trace[2131855223] 'agreement among raft nodes before linearized reading' (duration: 9.151758464s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.807116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:30.845603Z","time spent":"2.961502163s","remote":"127.0.0.1:48524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2010,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-05-27T06:09:33.807136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.357912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:09:33.807142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:24.654149Z","time spent":"9.152976548s","remote":"127.0.0.1:41416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "} {"level":"info","ts":"2026-05-27T06:09:33.807164Z","caller":"traceutil/trace.go:171","msg":"trace[1014230311] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:3698; }","duration":"496.431124ms","start":"2026-05-27T06:09:33.310721Z","end":"2026-05-27T06:09:33.807152Z","steps":["trace[1014230311] 'agreement among raft nodes before linearized reading' (duration: 496.390092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.807196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:33.310699Z","time spent":"496.490166ms","remote":"127.0.0.1:46302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.807287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.389665233s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b357351f367b7d\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-05-27T06:09:33.807318Z","caller":"traceutil/trace.go:171","msg":"trace[1448550857] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18b357351f367b7d; range_end:; response_count:1; response_revision:3698; }","duration":"3.389725815s","start":"2026-05-27T06:09:30.417584Z","end":"2026-05-27T06:09:33.80731Z","steps":["trace[1448550857] 'agreement among raft nodes before linearized reading' (duration: 3.389648583s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.807339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:30.417563Z","time spent":"3.389770606s","remote":"127.0.0.1:48394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":798,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b357351f367b7d\" "} {"level":"warn","ts":"2026-05-27T06:09:33.80734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.157285723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-27T06:09:33.807366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.276416228s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T06:09:33.807391Z","caller":"traceutil/trace.go:171","msg":"trace[1703892194] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3698; }","duration":"1.2764801s","start":"2026-05-27T06:09:32.530902Z","end":"2026-05-27T06:09:33.807383Z","steps":["trace[1703892194] 'agreement among raft nodes before linearized reading' (duration: 1.276431918s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:33.807396Z","caller":"traceutil/trace.go:171","msg":"trace[537437545] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3698; }","duration":"2.157400687s","start":"2026-05-27T06:09:31.649977Z","end":"2026-05-27T06:09:33.807378Z","steps":["trace[537437545] 'agreement among raft nodes before linearized reading' (duration: 2.157310504s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.807413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:32.53088Z","time spent":"1.276527171s","remote":"127.0.0.1:41350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.80739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.56314391s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:09:33.807505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.938095657s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:09:33.807531Z","caller":"traceutil/trace.go:171","msg":"trace[1797197686] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:3698; }","duration":"5.563340826s","start":"2026-05-27T06:09:28.24415Z","end":"2026-05-27T06:09:33.807491Z","steps":["trace[1797197686] 'agreement among raft nodes before linearized reading' (duration: 5.563087749s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:33.807556Z","caller":"traceutil/trace.go:171","msg":"trace[1137423462] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:3698; }","duration":"1.938182009s","start":"2026-05-27T06:09:31.869361Z","end":"2026-05-27T06:09:33.807543Z","steps":["trace[1137423462] 'agreement among raft nodes before linearized reading' (duration: 1.938108157s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.807596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:31.869339Z","time spent":"1.938244922s","remote":"127.0.0.1:48622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.807602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:28.244127Z","time spent":"5.563456339s","remote":"127.0.0.1:48562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.807626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.177649131s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:09:33.807643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.186063562s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:09:33.807654Z","caller":"traceutil/trace.go:171","msg":"trace[682721723] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:3698; }","duration":"5.177701333s","start":"2026-05-27T06:09:28.629945Z","end":"2026-05-27T06:09:33.807646Z","steps":["trace[682721723] 'agreement among raft nodes before linearized reading' (duration: 5.177655962s)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:09:33.807665Z","caller":"traceutil/trace.go:171","msg":"trace[1286945257] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:3698; }","duration":"5.186089232s","start":"2026-05-27T06:09:28.62157Z","end":"2026-05-27T06:09:33.807659Z","steps":["trace[1286945257] 'agreement among raft nodes before linearized reading' (duration: 5.186051841s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.807676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:28.629931Z","time spent":"5.177739004s","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"info","ts":"2026-05-27T06:09:33.806701Z","caller":"traceutil/trace.go:171","msg":"trace[65055783] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:3698; }","duration":"2.754539163s","start":"2026-05-27T06:09:31.052154Z","end":"2026-05-27T06:09:33.806693Z","steps":["trace[65055783] 'agreement among raft nodes before linearized reading' (duration: 2.754485872s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.807679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.161998298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.39\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-05-27T06:09:33.807685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:28.621513Z","time spent":"5.186166395s","remote":"127.0.0.1:48410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-05-27T06:09:33.807707Z","caller":"traceutil/trace.go:171","msg":"trace[599721476] range","detail":"{range_begin:/registry/masterleases/199.19.213.39; range_end:; response_count:1; response_revision:3698; }","duration":"4.16207002s","start":"2026-05-27T06:09:29.645629Z","end":"2026-05-27T06:09:33.807699Z","steps":["trace[599721476] 'agreement among raft nodes before linearized reading' (duration: 4.161995228s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:09:33.807735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:29.645595Z","time spent":"4.162134122s","remote":"127.0.0.1:48352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.39\" "} {"level":"warn","ts":"2026-05-27T06:09:33.807739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:31.052133Z","time spent":"2.755567301s","remote":"127.0.0.1:59170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:09:33.807442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:09:31.649951Z","time spent":"2.157475389s","remote":"127.0.0.1:41314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}