{"level":"warn","ts":"2026-05-27T13:42:31.946625Z","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-27T13:42:31.946788Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238: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-27T13:42:31.946977Z","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-27T13:42:31.947089Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-05-27T13:42:31.947136Z","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-27T13:42:31.947987Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]} {"level":"info","ts":"2026-05-27T13:42:31.94815Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238: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-27T13:42:31.953862Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.372803ms"} {"level":"info","ts":"2026-05-27T13:42:31.96312Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-05-27T13:42:31.963236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T13:42:31.963268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-05-27T13:42:31.963281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T13:42:31.963298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-05-27T13:42:31.963335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-05-27T13:42:31.972499Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T13:42:31.97459Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T13:42:31.977012Z","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-27T13:42:31.982809Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T13:42:31.983023Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T13:42:31.983133Z","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-27T13:42:31.983254Z","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-27T13:42:31.983276Z","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-27T13:42:31.985059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-05-27T13:42:31.985676Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-05-27T13:42:31.987362Z","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-27T13:42:31.98743Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-05-27T13:42:31.987488Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-05-27T13:42:31.987717Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T13:42:31.987783Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T13:42:32.46396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T13:42:32.464051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T13:42:32.464125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-05-27T13:42:32.464154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-05-27T13:42:32.464175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-05-27T13:42:32.464194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-05-27T13:42:32.464214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-05-27T13:42:32.500576Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T13:42:32.500896Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:42:32.501059Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:42:32.501166Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:42:32.501203Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T13:42:32.501402Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T13:42:32.507137Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-05-27T13:42:32.508207Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T13:42:32.508506Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:42:32.509059Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:42:32.509137Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-27T13:42:35.549674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.194228ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-27T13:42:35.549804Z","caller":"traceutil/trace.go:171","msg":"trace[1877104367] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"536.571377ms","start":"2026-05-27T13:42:35.013215Z","end":"2026-05-27T13:42:35.549786Z","steps":["trace[1877104367] 'process raft request' (duration: 329.782015ms)","trace[1877104367] 'compare' (duration: 206.014503ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:42:35.549866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:42:35.013198Z","time spent":"536.646518ms","remote":"127.0.0.1:55314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":699,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:42:36.43679Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532670288305191,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:42:36.949162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.122931ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-27T13:42:36.949311Z","caller":"traceutil/trace.go:171","msg":"trace[1613603224] linearizableReadLoop","detail":"{readStateIndex:111; appliedIndex:110; }","duration":"1.013553113s","start":"2026-05-27T13:42:35.935734Z","end":"2026-05-27T13:42:36.949287Z","steps":["trace[1613603224] 'read index received' (duration: 657.167644ms)","trace[1613603224] 'applied index is now lower than readState.Index' (duration: 356.383609ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:42:36.94937Z","caller":"traceutil/trace.go:171","msg":"trace[1140056174] transaction","detail":"{read_only:false; response_revision:107; number_of_response:1; }","duration":"1.334429177s","start":"2026-05-27T13:42:35.614933Z","end":"2026-05-27T13:42:36.949363Z","steps":["trace[1140056174] 'process raft request' (duration: 978.048728ms)","trace[1140056174] 'compare' (duration: 355.980518ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:42:36.949422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:42:35.614912Z","time spent":"1.334485798s","remote":"127.0.0.1:55314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":822,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:42:36.949582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01382464s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:42:36.949916Z","caller":"traceutil/trace.go:171","msg":"trace[1528359962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:107; }","duration":"1.014190949s","start":"2026-05-27T13:42:35.935692Z","end":"2026-05-27T13:42:36.949883Z","steps":["trace[1528359962] 'agreement among raft nodes before linearized reading' (duration: 1.013686686s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:42:36.95004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:42:35.935672Z","time spent":"1.014352092s","remote":"127.0.0.1:54970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T13:42:37.184709Z","caller":"traceutil/trace.go:171","msg":"trace[1750278417] linearizableReadLoop","detail":"{readStateIndex:112; appliedIndex:111; }","duration":"235.336124ms","start":"2026-05-27T13:42:36.949333Z","end":"2026-05-27T13:42:37.184669Z","steps":["trace[1750278417] 'read index received' (duration: 234.7998ms)","trace[1750278417] 'applied index is now lower than readState.Index' (duration: 534.794µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:42:37.18499Z","caller":"traceutil/trace.go:171","msg":"trace[69728130] transaction","detail":"{read_only:false; response_revision:108; number_of_response:1; }","duration":"386.881536ms","start":"2026-05-27T13:42:36.798065Z","end":"2026-05-27T13:42:37.184946Z","steps":["trace[69728130] 'process raft request' (duration: 386.135307ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:42:37.185166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:42:36.798036Z","time spent":"387.056151ms","remote":"127.0.0.1:55156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:42:37.185167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.210285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-27T13:42:37.185235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.395116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:42:37.185307Z","caller":"traceutil/trace.go:171","msg":"trace[1166743268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:108; }","duration":"409.530559ms","start":"2026-05-27T13:42:36.775761Z","end":"2026-05-27T13:42:37.185292Z","steps":["trace[1166743268] 'agreement among raft nodes before linearized reading' (duration: 409.418566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:42:37.185277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.256028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-27T13:42:37.185315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.76761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:daemon-set-controller\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:42:37.185411Z","caller":"traceutil/trace.go:171","msg":"trace[2000525815] range","detail":"{range_begin:/registry/clusterroles/system:controller:daemon-set-controller; range_end:; response_count:0; response_revision:108; }","duration":"232.882463ms","start":"2026-05-27T13:42:36.952515Z","end":"2026-05-27T13:42:37.185398Z","steps":["trace[2000525815] 'agreement among raft nodes before linearized reading' (duration: 232.685148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:42:37.185337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:42:36.775734Z","time spent":"409.598141ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-27T13:42:37.185373Z","caller":"traceutil/trace.go:171","msg":"trace[1781792318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:108; }","duration":"242.465901ms","start":"2026-05-27T13:42:36.942808Z","end":"2026-05-27T13:42:37.185274Z","steps":["trace[1781792318] 'agreement among raft nodes before linearized reading' (duration: 242.173454ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:42:37.185392Z","caller":"traceutil/trace.go:171","msg":"trace[126559107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:108; }","duration":"234.476874ms","start":"2026-05-27T13:42:36.950894Z","end":"2026-05-27T13:42:37.185371Z","steps":["trace[126559107] 'agreement among raft nodes before linearized reading' (duration: 234.212597ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:11.568473Z","caller":"traceutil/trace.go:171","msg":"trace[1882485911] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"145.400936ms","start":"2026-05-27T13:43:11.423047Z","end":"2026-05-27T13:43:11.568448Z","steps":["trace[1882485911] 'process raft request' (duration: 145.266143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:15.518643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.930699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:43:15.51867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.318954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:43:15.518728Z","caller":"traceutil/trace.go:171","msg":"trace[598911598] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:546; }","duration":"106.044012ms","start":"2026-05-27T13:43:15.412667Z","end":"2026-05-27T13:43:15.518711Z","steps":["trace[598911598] 'agreement among raft nodes before linearized reading' (duration: 105.890587ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:15.518752Z","caller":"traceutil/trace.go:171","msg":"trace[151284208] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:546; }","duration":"107.426147ms","start":"2026-05-27T13:43:15.411304Z","end":"2026-05-27T13:43:15.518731Z","steps":["trace[151284208] 'agreement among raft nodes before linearized reading' (duration: 107.261112ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:17.430759Z","caller":"traceutil/trace.go:171","msg":"trace[84204034] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"163.265059ms","start":"2026-05-27T13:43:17.26746Z","end":"2026-05-27T13:43:17.430725Z","steps":["trace[84204034] 'process raft request' (duration: 163.050884ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:17.742779Z","caller":"traceutil/trace.go:171","msg":"trace[387671748] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"267.118897ms","start":"2026-05-27T13:43:17.475638Z","end":"2026-05-27T13:43:17.742757Z","steps":["trace[387671748] 'read index received' (duration: 266.945522ms)","trace[387671748] 'applied index is now lower than readState.Index' (duration: 172.455µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:43:17.743077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.424365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:43:17.743133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.190487ms","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-27T13:43:17.743187Z","caller":"traceutil/trace.go:171","msg":"trace[1490964466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:597; }","duration":"153.283749ms","start":"2026-05-27T13:43:17.58989Z","end":"2026-05-27T13:43:17.743174Z","steps":["trace[1490964466] 'agreement among raft nodes before linearized reading' (duration: 153.078564ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:17.743126Z","caller":"traceutil/trace.go:171","msg":"trace[1878521072] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:597; }","duration":"267.504737ms","start":"2026-05-27T13:43:17.475607Z","end":"2026-05-27T13:43:17.743112Z","steps":["trace[1878521072] 'agreement among raft nodes before linearized reading' (duration: 267.386385ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:17.743398Z","caller":"traceutil/trace.go:171","msg":"trace[1400930848] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"466.788001ms","start":"2026-05-27T13:43:17.276587Z","end":"2026-05-27T13:43:17.743375Z","steps":["trace[1400930848] 'process raft request' (duration: 466.061952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:17.743467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:17.276571Z","time spent":"466.848902ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:43:19.828009Z","caller":"traceutil/trace.go:171","msg":"trace[1587912569] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"121.902773ms","start":"2026-05-27T13:43:19.706048Z","end":"2026-05-27T13:43:19.827951Z","steps":["trace[1587912569] 'process raft request' (duration: 121.494793ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:20.050511Z","caller":"traceutil/trace.go:171","msg":"trace[477772399] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"279.061449ms","start":"2026-05-27T13:43:19.771421Z","end":"2026-05-27T13:43:20.050483Z","steps":["trace[477772399] 'process raft request' (duration: 234.295585ms)","trace[477772399] 'compare' (duration: 44.373265ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:43:20.083337Z","caller":"traceutil/trace.go:171","msg":"trace[1729826487] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"251.349375ms","start":"2026-05-27T13:43:19.83197Z","end":"2026-05-27T13:43:20.08332Z","steps":["trace[1729826487] 'process raft request' (duration: 250.882733ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:20.08364Z","caller":"traceutil/trace.go:171","msg":"trace[77013631] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"171.392285ms","start":"2026-05-27T13:43:19.912198Z","end":"2026-05-27T13:43:20.08359Z","steps":["trace[77013631] 'process raft request' (duration: 170.908983ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:20.083762Z","caller":"traceutil/trace.go:171","msg":"trace[369020741] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"191.578172ms","start":"2026-05-27T13:43:19.892174Z","end":"2026-05-27T13:43:20.083753Z","steps":["trace[369020741] 'process raft request' (duration: 190.789913ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:20.377666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.221886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:43:20.377782Z","caller":"traceutil/trace.go:171","msg":"trace[450284751] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"280.787064ms","start":"2026-05-27T13:43:20.09697Z","end":"2026-05-27T13:43:20.377757Z","steps":["trace[450284751] 'process raft request' (duration: 161.040345ms)","trace[450284751] 'compare' (duration: 119.086043ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:43:20.379302Z","caller":"traceutil/trace.go:171","msg":"trace[26915047] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"253.777417ms","start":"2026-05-27T13:43:20.125496Z","end":"2026-05-27T13:43:20.379273Z","steps":["trace[26915047] 'process raft request' (duration: 253.464448ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:20.379442Z","caller":"traceutil/trace.go:171","msg":"trace[285292037] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"205.219736ms","start":"2026-05-27T13:43:20.1742Z","end":"2026-05-27T13:43:20.37942Z","steps":["trace[285292037] 'process raft request' (duration: 204.930629ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:20.379499Z","caller":"traceutil/trace.go:171","msg":"trace[1479380538] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:651; }","duration":"103.965082ms","start":"2026-05-27T13:43:20.27551Z","end":"2026-05-27T13:43:20.379475Z","steps":["trace[1479380538] 'read index received' (duration: 103.434117ms)","trace[1479380538] 'applied index is now lower than readState.Index' (duration: 527.794µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:43:20.379682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.154297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-05-27T13:43:20.379716Z","caller":"traceutil/trace.go:171","msg":"trace[1560543] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:632; }","duration":"104.242239ms","start":"2026-05-27T13:43:20.275463Z","end":"2026-05-27T13:43:20.379706Z","steps":["trace[1560543] 'agreement among raft nodes before linearized reading' (duration: 104.091596ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:20.379783Z","caller":"traceutil/trace.go:171","msg":"trace[818916518] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"201.075532ms","start":"2026-05-27T13:43:20.178691Z","end":"2026-05-27T13:43:20.379767Z","steps":["trace[818916518] 'process raft request' (duration: 200.60784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:20.762439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.041898ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:43:20.762585Z","caller":"traceutil/trace.go:171","msg":"trace[1806143360] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:634; }","duration":"105.222593ms","start":"2026-05-27T13:43:20.657338Z","end":"2026-05-27T13:43:20.76256Z","steps":["trace[1806143360] 'range keys from in-memory index tree' (duration: 105.008087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.015787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.0816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-05-27T13:43:21.015901Z","caller":"traceutil/trace.go:171","msg":"trace[1333802620] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"140.232823ms","start":"2026-05-27T13:43:20.875643Z","end":"2026-05-27T13:43:21.015875Z","steps":["trace[1333802620] 'range keys from in-memory index tree' (duration: 139.833714ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:25.073077Z","caller":"traceutil/trace.go:171","msg":"trace[188605234] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:682; }","duration":"480.49267ms","start":"2026-05-27T13:43:24.592554Z","end":"2026-05-27T13:43:25.073047Z","steps":["trace[188605234] 'read index received' (duration: 480.194583ms)","trace[188605234] 'applied index is now lower than readState.Index' (duration: 296.607µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:43:25.073122Z","caller":"traceutil/trace.go:171","msg":"trace[1452681525] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"680.902429ms","start":"2026-05-27T13:43:24.392187Z","end":"2026-05-27T13:43:25.073089Z","steps":["trace[1452681525] 'process raft request' (duration: 680.596282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:25.073343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.765607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wl4dm\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-27T13:43:25.073388Z","caller":"traceutil/trace.go:171","msg":"trace[173966357] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wl4dm; range_end:; response_count:1; response_revision:660; }","duration":"480.855319ms","start":"2026-05-27T13:43:24.592523Z","end":"2026-05-27T13:43:25.073378Z","steps":["trace[173966357] 'agreement among raft nodes before linearized reading' (duration: 480.662605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:25.073383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:24.392161Z","time spent":"681.104455ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:43:25.073421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:24.592509Z","time spent":"480.90318ms","remote":"127.0.0.1:55156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-wl4dm\" "} {"level":"warn","ts":"2026-05-27T13:43:25.073476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.14298ms","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-27T13:43:25.073549Z","caller":"traceutil/trace.go:171","msg":"trace[2081182967] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:660; }","duration":"468.248833ms","start":"2026-05-27T13:43:24.605283Z","end":"2026-05-27T13:43:25.073532Z","steps":["trace[2081182967] 'agreement among raft nodes before linearized reading' (duration: 468.058738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:25.073594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:24.60527Z","time spent":"468.315524ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:43:25.073841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.457387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:43:25.073874Z","caller":"traceutil/trace.go:171","msg":"trace[747121265] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:660; }","duration":"386.526288ms","start":"2026-05-27T13:43:24.687338Z","end":"2026-05-27T13:43:25.073864Z","steps":["trace[747121265] 'agreement among raft nodes before linearized reading' (duration: 386.483897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:25.0739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:24.687317Z","time spent":"386.577039ms","remote":"127.0.0.1:54970","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-27T13:43:25.255895Z","caller":"traceutil/trace.go:171","msg":"trace[968614369] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"163.371258ms","start":"2026-05-27T13:43:25.092496Z","end":"2026-05-27T13:43:25.255868Z","steps":["trace[968614369] 'process raft request' (duration: 163.190444ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:25.261907Z","caller":"traceutil/trace.go:171","msg":"trace[923644854] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"102.16438ms","start":"2026-05-27T13:43:25.159712Z","end":"2026-05-27T13:43:25.261876Z","steps":["trace[923644854] 'process raft request' (duration: 102.028596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:25.654087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.660179ms","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-27T13:43:25.654428Z","caller":"traceutil/trace.go:171","msg":"trace[951707928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:664; }","duration":"180.024408ms","start":"2026-05-27T13:43:25.474385Z","end":"2026-05-27T13:43:25.654409Z","steps":["trace[951707928] 'range keys from in-memory index tree' (duration: 179.413352ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:25.771912Z","caller":"traceutil/trace.go:171","msg":"trace[1055694865] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"112.847108ms","start":"2026-05-27T13:43:25.659048Z","end":"2026-05-27T13:43:25.771895Z","steps":["trace[1055694865] 'process raft request' (duration: 112.732855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:27.315481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210391465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:43:27.315572Z","caller":"traceutil/trace.go:171","msg":"trace[1050259753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:665; }","duration":"1.210537188s","start":"2026-05-27T13:43:26.105013Z","end":"2026-05-27T13:43:27.31555Z","steps":["trace[1050259753] 'range keys from in-memory index tree' (duration: 1.21017123s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:27.31561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:26.104993Z","time spent":"1.210607211s","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:43:27.315891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.927825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:43:27.315964Z","caller":"traceutil/trace.go:171","msg":"trace[2058708889] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:665; }","duration":"628.009927ms","start":"2026-05-27T13:43:26.687936Z","end":"2026-05-27T13:43:27.315946Z","steps":["trace[2058708889] 'range keys from in-memory index tree' (duration: 627.822453ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:27.315995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:26.687871Z","time spent":"628.116719ms","remote":"127.0.0.1:54970","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-27T13:43:27.316037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.426288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-27T13:43:27.31607Z","caller":"traceutil/trace.go:171","msg":"trace[983230543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:665; }","duration":"238.5028ms","start":"2026-05-27T13:43:27.077558Z","end":"2026-05-27T13:43:27.31606Z","steps":["trace[983230543] 'range keys from in-memory index tree' (duration: 238.302684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:27.316198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.230081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-27T13:43:27.316241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.06505ms","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-27T13:43:27.316266Z","caller":"traceutil/trace.go:171","msg":"trace[1782436988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:665; }","duration":"220.340844ms","start":"2026-05-27T13:43:27.095908Z","end":"2026-05-27T13:43:27.316249Z","steps":["trace[1782436988] 'range keys from in-memory index tree' (duration: 220.059297ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:27.316271Z","caller":"traceutil/trace.go:171","msg":"trace[1875556985] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:665; }","duration":"213.134622ms","start":"2026-05-27T13:43:27.103128Z","end":"2026-05-27T13:43:27.316263Z","steps":["trace[1875556985] 'range keys from in-memory index tree' (duration: 212.941687ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:40.076002Z","caller":"traceutil/trace.go:171","msg":"trace[1527998068] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"167.86764ms","start":"2026-05-27T13:43:39.908104Z","end":"2026-05-27T13:43:40.075972Z","steps":["trace[1527998068] 'process raft request' (duration: 167.684206ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:43.015305Z","caller":"traceutil/trace.go:171","msg":"trace[651023816] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"304.292913ms","start":"2026-05-27T13:43:42.710981Z","end":"2026-05-27T13:43:43.015274Z","steps":["trace[651023816] 'process raft request' (duration: 304.16768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:43.015608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:42.710954Z","time spent":"304.495157ms","remote":"127.0.0.1:55212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:43:51.871672Z","caller":"traceutil/trace.go:171","msg":"trace[557004616] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"108.094648ms","start":"2026-05-27T13:43:51.763555Z","end":"2026-05-27T13:43:51.87165Z","steps":["trace[557004616] 'process raft request' (duration: 107.938534ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:51.871689Z","caller":"traceutil/trace.go:171","msg":"trace[1041593638] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"107.778979ms","start":"2026-05-27T13:43:51.763888Z","end":"2026-05-27T13:43:51.871667Z","steps":["trace[1041593638] 'process raft request' (duration: 107.745409ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:51.871804Z","caller":"traceutil/trace.go:171","msg":"trace[1141795438] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"107.936304ms","start":"2026-05-27T13:43:51.763854Z","end":"2026-05-27T13:43:51.871791Z","steps":["trace[1141795438] 'process raft request' (duration: 107.742119ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.035419Z","caller":"traceutil/trace.go:171","msg":"trace[1918827165] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"192.758118ms","start":"2026-05-27T13:43:55.84261Z","end":"2026-05-27T13:43:56.035368Z","steps":["trace[1918827165] 'process raft request' (duration: 192.395829ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.038527Z","caller":"traceutil/trace.go:171","msg":"trace[1036103280] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"155.998539ms","start":"2026-05-27T13:43:55.882488Z","end":"2026-05-27T13:43:56.038487Z","steps":["trace[1036103280] 'process raft request' (duration: 155.587019ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:57.924984Z","caller":"traceutil/trace.go:171","msg":"trace[673487704] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"159.326304ms","start":"2026-05-27T13:43:57.765627Z","end":"2026-05-27T13:43:57.924953Z","steps":["trace[673487704] 'process raft request' (duration: 144.147081ms)","trace[673487704] 'compare' (duration: 15.033299ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:44:18.755374Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532670288307426,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:44:18.888302Z","caller":"traceutil/trace.go:171","msg":"trace[1274396159] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"745.744519ms","start":"2026-05-27T13:44:18.142537Z","end":"2026-05-27T13:44:18.888281Z","steps":["trace[1274396159] 'process raft request' (duration: 745.615536ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:18.888319Z","caller":"traceutil/trace.go:171","msg":"trace[50807682] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1244; }","duration":"633.891189ms","start":"2026-05-27T13:44:18.254403Z","end":"2026-05-27T13:44:18.888295Z","steps":["trace[50807682] 'read index received' (duration: 633.883888ms)","trace[50807682] 'applied index is now lower than readState.Index' (duration: 5.711µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:44:18.88846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:18.142514Z","time spent":"745.848462ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:44:18.888553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.139695ms","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-27T13:44:18.888654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.304512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:44:18.888653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.538483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:44:18.889427Z","caller":"traceutil/trace.go:171","msg":"trace[2097709163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1207; }","duration":"201.403436ms","start":"2026-05-27T13:44:18.687997Z","end":"2026-05-27T13:44:18.889401Z","steps":["trace[2097709163] 'agreement among raft nodes before linearized reading' (duration: 200.489982ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:18.889805Z","caller":"traceutil/trace.go:171","msg":"trace[1699091583] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1207; }","duration":"111.073761ms","start":"2026-05-27T13:44:18.778278Z","end":"2026-05-27T13:44:18.889351Z","steps":["trace[1699091583] 'agreement among raft nodes before linearized reading' (duration: 110.307741ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:18.890106Z","caller":"traceutil/trace.go:171","msg":"trace[1744093623] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1207; }","duration":"634.936766ms","start":"2026-05-27T13:44:18.254386Z","end":"2026-05-27T13:44:18.889323Z","steps":["trace[1744093623] 'agreement among raft nodes before linearized reading' (duration: 634.029623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:18.890183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:18.254329Z","time spent":"635.836438ms","remote":"127.0.0.1:55250","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":"info","ts":"2026-05-27T13:44:21.548338Z","caller":"traceutil/trace.go:171","msg":"trace[133029820] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"119.594788ms","start":"2026-05-27T13:44:21.428717Z","end":"2026-05-27T13:44:21.548312Z","steps":["trace[133029820] 'process raft request' (duration: 119.460564ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:27.819967Z","caller":"traceutil/trace.go:171","msg":"trace[977929912] linearizableReadLoop","detail":"{readStateIndex:1326; appliedIndex:1325; }","duration":"105.359438ms","start":"2026-05-27T13:44:27.714588Z","end":"2026-05-27T13:44:27.819948Z","steps":["trace[977929912] 'read index received' (duration: 105.274256ms)","trace[977929912] 'applied index is now lower than readState.Index' (duration: 84.362µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:44:27.820074Z","caller":"traceutil/trace.go:171","msg":"trace[270693875] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"105.770688ms","start":"2026-05-27T13:44:27.714266Z","end":"2026-05-27T13:44:27.820037Z","steps":["trace[270693875] 'process raft request' (duration: 105.576934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:27.820268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.633585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-27T13:44:27.820379Z","caller":"traceutil/trace.go:171","msg":"trace[1929584663] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1284; }","duration":"105.778318ms","start":"2026-05-27T13:44:27.71456Z","end":"2026-05-27T13:44:27.820339Z","steps":["trace[1929584663] 'agreement among raft nodes before linearized reading' (duration: 105.502441ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:35.932396Z","caller":"traceutil/trace.go:171","msg":"trace[542739566] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"108.717544ms","start":"2026-05-27T13:44:35.823663Z","end":"2026-05-27T13:44:35.93238Z","steps":["trace[542739566] 'process raft request' (duration: 108.479277ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:37.227143Z","caller":"traceutil/trace.go:171","msg":"trace[1110733068] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"167.483393ms","start":"2026-05-27T13:44:37.059626Z","end":"2026-05-27T13:44:37.22711Z","steps":["trace[1110733068] 'process raft request' (duration: 167.247987ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:42.18989Z","caller":"traceutil/trace.go:171","msg":"trace[859803993] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"318.024558ms","start":"2026-05-27T13:44:41.871842Z","end":"2026-05-27T13:44:42.189866Z","steps":["trace[859803993] 'process raft request' (duration: 317.889335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:42.190037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:41.87182Z","time spent":"318.140712ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:44:42.193846Z","caller":"traceutil/trace.go:171","msg":"trace[1918004628] linearizableReadLoop","detail":"{readStateIndex:1504; appliedIndex:1502; }","duration":"154.688821ms","start":"2026-05-27T13:44:42.039127Z","end":"2026-05-27T13:44:42.193815Z","steps":["trace[1918004628] 'read index received' (duration: 150.687299ms)","trace[1918004628] 'applied index is now lower than readState.Index' (duration: 4.000332ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:44:42.193971Z","caller":"traceutil/trace.go:171","msg":"trace[1374862658] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"208.400301ms","start":"2026-05-27T13:44:41.985512Z","end":"2026-05-27T13:44:42.193912Z","steps":["trace[1374862658] 'process raft request' (duration: 208.159925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:42.194119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.970388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-27T13:44:42.194141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.008865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-27T13:44:42.194176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.980259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:44:42.194181Z","caller":"traceutil/trace.go:171","msg":"trace[1164612285] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1459; }","duration":"155.08646ms","start":"2026-05-27T13:44:42.039076Z","end":"2026-05-27T13:44:42.194163Z","steps":["trace[1164612285] 'agreement among raft nodes before linearized reading' (duration: 154.898116ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:42.194222Z","caller":"traceutil/trace.go:171","msg":"trace[1933387563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1459; }","duration":"144.060482ms","start":"2026-05-27T13:44:42.050148Z","end":"2026-05-27T13:44:42.194209Z","steps":["trace[1933387563] 'agreement among raft nodes before linearized reading' (duration: 143.882827ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:42.194214Z","caller":"traceutil/trace.go:171","msg":"trace[1919350276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1459; }","duration":"117.113977ms","start":"2026-05-27T13:44:42.077082Z","end":"2026-05-27T13:44:42.194196Z","steps":["trace[1919350276] 'agreement among raft nodes before linearized reading' (duration: 116.917392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:42.194357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.264989ms","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-27T13:44:42.194389Z","caller":"traceutil/trace.go:171","msg":"trace[1120956654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1459; }","duration":"154.332681ms","start":"2026-05-27T13:44:42.040048Z","end":"2026-05-27T13:44:42.194381Z","steps":["trace[1120956654] 'agreement among raft nodes before linearized reading' (duration: 153.947551ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:44.475521Z","caller":"traceutil/trace.go:171","msg":"trace[1965023951] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"262.390149ms","start":"2026-05-27T13:44:44.213099Z","end":"2026-05-27T13:44:44.475489Z","steps":["trace[1965023951] 'process raft request' (duration: 262.185433ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:44.566651Z","caller":"traceutil/trace.go:171","msg":"trace[811494381] linearizableReadLoop","detail":"{readStateIndex:1521; appliedIndex:1517; }","duration":"117.712123ms","start":"2026-05-27T13:44:44.448913Z","end":"2026-05-27T13:44:44.566626Z","steps":["trace[811494381] 'read index received' (duration: 26.331836ms)","trace[811494381] 'applied index is now lower than readState.Index' (duration: 91.379197ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:44:44.566886Z","caller":"traceutil/trace.go:171","msg":"trace[1337159102] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"353.584931ms","start":"2026-05-27T13:44:44.213281Z","end":"2026-05-27T13:44:44.566866Z","steps":["trace[1337159102] 'process raft request' (duration: 353.241962ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:44.567018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:44.213272Z","time spent":"353.668503ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:44:44.567014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.083253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:44:44.567086Z","caller":"traceutil/trace.go:171","msg":"trace[1704226789] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1474; }","duration":"118.208526ms","start":"2026-05-27T13:44:44.448864Z","end":"2026-05-27T13:44:44.567073Z","steps":["trace[1704226789] 'agreement among raft nodes before linearized reading' (duration: 117.897698ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:44.567229Z","caller":"traceutil/trace.go:171","msg":"trace[1157677140] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"353.54762ms","start":"2026-05-27T13:44:44.213636Z","end":"2026-05-27T13:44:44.567183Z","steps":["trace[1157677140] 'process raft request' (duration: 352.948525ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:44.567468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:44.213628Z","time spent":"353.737874ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:44:44.566879Z","caller":"traceutil/trace.go:171","msg":"trace[233336396] transaction","detail":"{read_only:false; response_revision:1472; number_of_response:1; }","duration":"353.717204ms","start":"2026-05-27T13:44:44.213117Z","end":"2026-05-27T13:44:44.566834Z","steps":["trace[233336396] 'process raft request' (duration: 282.889529ms)","trace[233336396] 'compare' (duration: 70.388804ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:44:44.567725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:44.213101Z","time spent":"354.501273ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:45:01.453356Z","caller":"traceutil/trace.go:171","msg":"trace[1199062662] linearizableReadLoop","detail":"{readStateIndex:1851; appliedIndex:1850; }","duration":"115.105259ms","start":"2026-05-27T13:45:01.338233Z","end":"2026-05-27T13:45:01.453338Z","steps":["trace[1199062662] 'read index received' (duration: 115.003917ms)","trace[1199062662] 'applied index is now lower than readState.Index' (duration: 100.732µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:01.453679Z","caller":"traceutil/trace.go:171","msg":"trace[911492095] transaction","detail":"{read_only:false; response_revision:1779; number_of_response:1; }","duration":"154.046057ms","start":"2026-05-27T13:45:01.299609Z","end":"2026-05-27T13:45:01.453655Z","steps":["trace[911492095] 'process raft request' (duration: 153.557985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:01.453905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.669344ms","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-27T13:45:01.453928Z","caller":"traceutil/trace.go:171","msg":"trace[542520223] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1779; }","duration":"115.747096ms","start":"2026-05-27T13:45:01.338174Z","end":"2026-05-27T13:45:01.453921Z","steps":["trace[542520223] 'agreement among raft nodes before linearized reading' (duration: 115.648613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:09.735394Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532670288308786,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:45:09.750724Z","caller":"traceutil/trace.go:171","msg":"trace[864271858] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"560.194591ms","start":"2026-05-27T13:45:09.190504Z","end":"2026-05-27T13:45:09.750699Z","steps":["trace[864271858] 'process raft request' (duration: 560.031567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:09.75086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:09.190486Z","time spent":"560.294014ms","remote":"127.0.0.1:55156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10967,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:45:09.761098Z","caller":"traceutil/trace.go:171","msg":"trace[447666172] linearizableReadLoop","detail":"{readStateIndex:1965; appliedIndex:1963; }","duration":"526.788414ms","start":"2026-05-27T13:45:09.234294Z","end":"2026-05-27T13:45:09.761082Z","steps":["trace[447666172] 'read index received' (duration: 516.293019ms)","trace[447666172] 'applied index is now lower than readState.Index' (duration: 10.494465ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:09.761171Z","caller":"traceutil/trace.go:171","msg":"trace[1013363974] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"282.887626ms","start":"2026-05-27T13:45:09.478275Z","end":"2026-05-27T13:45:09.761163Z","steps":["trace[1013363974] 'process raft request' (duration: 282.715812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:09.761411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.079271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-27T13:45:09.761456Z","caller":"traceutil/trace.go:171","msg":"trace[911416119] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1891; }","duration":"527.177934ms","start":"2026-05-27T13:45:09.234264Z","end":"2026-05-27T13:45:09.761442Z","steps":["trace[911416119] 'agreement among raft nodes before linearized reading' (duration: 526.986219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:09.761483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:09.234253Z","time spent":"527.224095ms","remote":"127.0.0.1:46866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-27T13:45:09.805681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.482963ms","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-27T13:45:09.805749Z","caller":"traceutil/trace.go:171","msg":"trace[72892615] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1895; }","duration":"302.582976ms","start":"2026-05-27T13:45:09.503151Z","end":"2026-05-27T13:45:09.805734Z","steps":["trace[72892615] 'agreement among raft nodes before linearized reading' (duration: 302.416792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:09.805783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:09.503128Z","time spent":"302.647208ms","remote":"127.0.0.1:55250","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":"warn","ts":"2026-05-27T13:45:09.805803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.586862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:45:09.805895Z","caller":"traceutil/trace.go:171","msg":"trace[415865928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1895; }","duration":"115.711596ms","start":"2026-05-27T13:45:09.690169Z","end":"2026-05-27T13:45:09.80588Z","steps":["trace[415865928] 'agreement among raft nodes before linearized reading' (duration: 115.596973ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:09.934208Z","caller":"traceutil/trace.go:171","msg":"trace[414476832] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"122.344973ms","start":"2026-05-27T13:45:09.811833Z","end":"2026-05-27T13:45:09.934178Z","steps":["trace[414476832] 'process raft request' (duration: 100.1303ms)","trace[414476832] 'compare' (duration: 22.09148ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:10.013105Z","caller":"traceutil/trace.go:171","msg":"trace[207516895] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"199.047689ms","start":"2026-05-27T13:45:09.814034Z","end":"2026-05-27T13:45:10.013082Z","steps":["trace[207516895] 'process raft request' (duration: 198.891375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:11.015027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.902075ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:45:11.015178Z","caller":"traceutil/trace.go:171","msg":"trace[1703270524] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1897; }","duration":"357.07692ms","start":"2026-05-27T13:45:10.658082Z","end":"2026-05-27T13:45:11.015159Z","steps":["trace[1703270524] 'range keys from in-memory index tree' (duration: 356.879425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:11.015714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.67436ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:45:11.015834Z","caller":"traceutil/trace.go:171","msg":"trace[733895362] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"859.883295ms","start":"2026-05-27T13:45:10.155921Z","end":"2026-05-27T13:45:11.015804Z","steps":["trace[733895362] 'process raft request' (duration: 647.931888ms)","trace[733895362] 'compare' (duration: 211.412203ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:11.01594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:10.155897Z","time spent":"860.006568ms","remote":"127.0.0.1:55250","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-27T13:45:11.10893Z","caller":"traceutil/trace.go:171","msg":"trace[1967194774] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1971; }","duration":"524.545077ms","start":"2026-05-27T13:45:10.584363Z","end":"2026-05-27T13:45:11.108908Z","steps":["trace[1967194774] 'read index received' (duration: 219.556521ms)","trace[1967194774] 'applied index is now lower than readState.Index' (duration: 304.987606ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:11.109074Z","caller":"traceutil/trace.go:171","msg":"trace[407948492] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"829.477873ms","start":"2026-05-27T13:45:10.279568Z","end":"2026-05-27T13:45:11.109046Z","steps":["trace[407948492] 'process raft request' (duration: 829.185426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:11.109234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:10.279543Z","time spent":"829.598617ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:11.109367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.99817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-27T13:45:11.109441Z","caller":"traceutil/trace.go:171","msg":"trace[218820495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1899; }","duration":"525.116373ms","start":"2026-05-27T13:45:10.584306Z","end":"2026-05-27T13:45:11.109423Z","steps":["trace[218820495] 'agreement among raft nodes before linearized reading' (duration: 524.725523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:11.109493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:10.584287Z","time spent":"525.194615ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T13:45:11.170729Z","caller":"traceutil/trace.go:171","msg":"trace[243595983] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"218.617446ms","start":"2026-05-27T13:45:10.95209Z","end":"2026-05-27T13:45:11.170707Z","steps":["trace[243595983] 'process raft request' (duration: 194.856974ms)","trace[243595983] 'compare' (duration: 23.577237ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:11.171117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.713742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:45:11.171243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.227923ms","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-27T13:45:11.171279Z","caller":"traceutil/trace.go:171","msg":"trace[1546640823] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1902; }","duration":"483.830985ms","start":"2026-05-27T13:45:10.687339Z","end":"2026-05-27T13:45:11.17117Z","steps":["trace[1546640823] 'agreement among raft nodes before linearized reading' (duration: 483.720852ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:11.171326Z","caller":"traceutil/trace.go:171","msg":"trace[1699979755] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1902; }","duration":"463.340105ms","start":"2026-05-27T13:45:10.707967Z","end":"2026-05-27T13:45:11.171307Z","steps":["trace[1699979755] 'agreement among raft nodes before linearized reading' (duration: 463.14232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:11.171342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:10.68732Z","time spent":"484.00609ms","remote":"127.0.0.1:54970","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-27T13:45:11.171368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:10.707956Z","time spent":"463.404007ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:45:11.171406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.597597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1485273c-910e-4378-b52a-fc541476a56b\" ","response":"range_response_count:1 size:3747"} {"level":"warn","ts":"2026-05-27T13:45:11.171519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.791328ms","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-27T13:45:11.171517Z","caller":"traceutil/trace.go:171","msg":"trace[1906276983] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1485273c-910e-4378-b52a-fc541476a56b; range_end:; response_count:1; response_revision:1902; }","duration":"153.769921ms","start":"2026-05-27T13:45:11.017724Z","end":"2026-05-27T13:45:11.171494Z","steps":["trace[1906276983] 'agreement among raft nodes before linearized reading' (duration: 153.444273ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:11.171576Z","caller":"traceutil/trace.go:171","msg":"trace[1378094542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1902; }","duration":"480.837589ms","start":"2026-05-27T13:45:10.690721Z","end":"2026-05-27T13:45:11.171559Z","steps":["trace[1378094542] 'agreement among raft nodes before linearized reading' (duration: 480.739357ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:11.171626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:10.690689Z","time spent":"480.928261ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:45:11.171403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.9613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-27T13:45:11.171701Z","caller":"traceutil/trace.go:171","msg":"trace[1096754697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1902; }","duration":"475.313279ms","start":"2026-05-27T13:45:10.696374Z","end":"2026-05-27T13:45:11.171687Z","steps":["trace[1096754697] 'agreement among raft nodes before linearized reading' (duration: 474.834547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:11.171772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:10.696351Z","time spent":"475.391091ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-27T13:45:11.171634Z","caller":"traceutil/trace.go:171","msg":"trace[1695212845] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"210.368787ms","start":"2026-05-27T13:45:10.961246Z","end":"2026-05-27T13:45:11.171614Z","steps":["trace[1695212845] 'process raft request' (duration: 209.406772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:11.172111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.376495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-27T13:45:11.172393Z","caller":"traceutil/trace.go:171","msg":"trace[1508809282] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1902; }","duration":"405.680963ms","start":"2026-05-27T13:45:10.766689Z","end":"2026-05-27T13:45:11.17237Z","steps":["trace[1508809282] 'agreement among raft nodes before linearized reading' (duration: 404.75672ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:11.172532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:10.766673Z","time spent":"405.839116ms","remote":"127.0.0.1:46866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-27T13:45:22.796607Z","caller":"traceutil/trace.go:171","msg":"trace[2106947383] linearizableReadLoop","detail":"{readStateIndex:2077; appliedIndex:2076; }","duration":"108.291848ms","start":"2026-05-27T13:45:22.6883Z","end":"2026-05-27T13:45:22.796592Z","steps":["trace[2106947383] 'read index received' (duration: 108.152074ms)","trace[2106947383] 'applied index is now lower than readState.Index' (duration: 139.214µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:22.796687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.399211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:45:22.796703Z","caller":"traceutil/trace.go:171","msg":"trace[2055374591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2000; }","duration":"108.469713ms","start":"2026-05-27T13:45:22.688228Z","end":"2026-05-27T13:45:22.796698Z","steps":["trace[2055374591] 'agreement among raft nodes before linearized reading' (duration: 108.418272ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:22.796865Z","caller":"traceutil/trace.go:171","msg":"trace[1065132619] transaction","detail":"{read_only:false; response_revision:2000; number_of_response:1; }","duration":"131.967909ms","start":"2026-05-27T13:45:22.664889Z","end":"2026-05-27T13:45:22.796857Z","steps":["trace[1065132619] 'process raft request' (duration: 131.60713ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:23.527808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.429983ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-27T13:45:23.52817Z","caller":"traceutil/trace.go:171","msg":"trace[1930934990] linearizableReadLoop","detail":"{readStateIndex:2081; appliedIndex:2078; }","duration":"303.609896ms","start":"2026-05-27T13:45:23.224541Z","end":"2026-05-27T13:45:23.528151Z","steps":["trace[1930934990] 'read index received' (duration: 75.843665ms)","trace[1930934990] 'applied index is now lower than readState.Index' (duration: 227.765051ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:23.528222Z","caller":"traceutil/trace.go:171","msg":"trace[1063673167] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"317.16704ms","start":"2026-05-27T13:45:23.210993Z","end":"2026-05-27T13:45:23.52816Z","steps":["trace[1063673167] 'process raft request' (duration: 316.920454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:23.528389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.018198ms","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-27T13:45:23.528426Z","caller":"traceutil/trace.go:171","msg":"trace[1245128213] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2003; }","duration":"295.10085ms","start":"2026-05-27T13:45:23.233316Z","end":"2026-05-27T13:45:23.528417Z","steps":["trace[1245128213] 'agreement among raft nodes before linearized reading' (duration: 294.948696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:23.528454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.382404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-27T13:45:23.528452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.882083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-27T13:45:23.528513Z","caller":"traceutil/trace.go:171","msg":"trace[2143711736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2003; }","duration":"287.470776ms","start":"2026-05-27T13:45:23.241027Z","end":"2026-05-27T13:45:23.528498Z","steps":["trace[2143711736] 'agreement among raft nodes before linearized reading' (duration: 287.272191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:23.528508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:23.210964Z","time spent":"317.361074ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:23.528619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.315109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:45:23.528572Z","caller":"traceutil/trace.go:171","msg":"trace[1726665288] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2003; }","duration":"304.044317ms","start":"2026-05-27T13:45:23.224508Z","end":"2026-05-27T13:45:23.528553Z","steps":["trace[1726665288] 'agreement among raft nodes before linearized reading' (duration: 303.74698ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:23.528223Z","caller":"traceutil/trace.go:171","msg":"trace[628201852] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"310.165102ms","start":"2026-05-27T13:45:23.218017Z","end":"2026-05-27T13:45:23.528182Z","steps":["trace[628201852] 'process raft request' (duration: 310.08111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:23.528713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:23.224497Z","time spent":"304.207021ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T13:45:23.528738Z","caller":"traceutil/trace.go:171","msg":"trace[361532565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2003; }","duration":"292.399841ms","start":"2026-05-27T13:45:23.236287Z","end":"2026-05-27T13:45:23.528686Z","steps":["trace[361532565] 'agreement among raft nodes before linearized reading' (duration: 292.080573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:23.528892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:23.217997Z","time spent":"310.714865ms","remote":"127.0.0.1:55250","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-27T13:45:23.528975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.235229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-27T13:45:23.529017Z","caller":"traceutil/trace.go:171","msg":"trace[629228907] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2003; }","duration":"285.326361ms","start":"2026-05-27T13:45:23.243679Z","end":"2026-05-27T13:45:23.529005Z","steps":["trace[629228907] 'agreement among raft nodes before linearized reading' (duration: 284.612043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:24.075812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.621029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:45:24.076317Z","caller":"traceutil/trace.go:171","msg":"trace[1773363601] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"248.034575ms","start":"2026-05-27T13:45:23.828214Z","end":"2026-05-27T13:45:24.076248Z","steps":["trace[1773363601] 'process raft request' (duration: 106.900193ms)","trace[1773363601] 'compare' (duration: 140.512506ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:25.678867Z","caller":"traceutil/trace.go:171","msg":"trace[699357671] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"100.12429ms","start":"2026-05-27T13:45:25.578722Z","end":"2026-05-27T13:45:25.678846Z","steps":["trace[699357671] 'process raft request' (duration: 91.863021ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:29.395256Z","caller":"traceutil/trace.go:171","msg":"trace[524996529] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"204.022699ms","start":"2026-05-27T13:45:29.191207Z","end":"2026-05-27T13:45:29.39523Z","steps":["trace[524996529] 'process raft request' (duration: 203.841894ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:31.518003Z","caller":"traceutil/trace.go:171","msg":"trace[1162892223] transaction","detail":"{read_only:false; response_revision:2052; number_of_response:1; }","duration":"118.024056ms","start":"2026-05-27T13:45:31.39996Z","end":"2026-05-27T13:45:31.517984Z","steps":["trace[1162892223] 'process raft request' (duration: 117.902953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.223556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.263084ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:45:50.223705Z","caller":"traceutil/trace.go:171","msg":"trace[1020651218] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"301.235039ms","start":"2026-05-27T13:45:49.922441Z","end":"2026-05-27T13:45:50.223676Z","steps":["trace[1020651218] 'process raft request' (duration: 93.76879ms)","trace[1020651218] 'compare' (duration: 206.781762ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:50.223864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.922415Z","time spent":"301.361952ms","remote":"127.0.0.1:55250","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-27T13:45:51.788789Z","caller":"traceutil/trace.go:171","msg":"trace[654761083] linearizableReadLoop","detail":"{readStateIndex:2254; appliedIndex:2253; }","duration":"101.790056ms","start":"2026-05-27T13:45:51.686968Z","end":"2026-05-27T13:45:51.788758Z","steps":["trace[654761083] 'read index received' (duration: 21.381514ms)","trace[654761083] 'applied index is now lower than readState.Index' (duration: 80.407162ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:51.789032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.682852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:45:51.789003Z","caller":"traceutil/trace.go:171","msg":"trace[2017664646] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"137.183634ms","start":"2026-05-27T13:45:51.651737Z","end":"2026-05-27T13:45:51.788921Z","steps":["trace[2017664646] 'process raft request' (duration: 56.6911ms)","trace[2017664646] 'compare' (duration: 80.167596ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:51.789105Z","caller":"traceutil/trace.go:171","msg":"trace[256706871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2170; }","duration":"101.787094ms","start":"2026-05-27T13:45:51.687305Z","end":"2026-05-27T13:45:51.789092Z","steps":["trace[256706871] 'agreement among raft nodes before linearized reading' (duration: 101.684471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.789222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.992821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:45:51.789273Z","caller":"traceutil/trace.go:171","msg":"trace[808383920] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2170; }","duration":"102.325569ms","start":"2026-05-27T13:45:51.686933Z","end":"2026-05-27T13:45:51.789258Z","steps":["trace[808383920] 'agreement among raft nodes before linearized reading' (duration: 101.993931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:52.587443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.152377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:45:52.588077Z","caller":"traceutil/trace.go:171","msg":"trace[2091180438] linearizableReadLoop","detail":"{readStateIndex:2256; appliedIndex:2254; }","duration":"774.099668ms","start":"2026-05-27T13:45:51.813951Z","end":"2026-05-27T13:45:52.58805Z","steps":["trace[2091180438] 'read index received' (duration: 487.153662ms)","trace[2091180438] 'applied index is now lower than readState.Index' (duration: 286.944886ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:52.588219Z","caller":"traceutil/trace.go:171","msg":"trace[565620194] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"775.041732ms","start":"2026-05-27T13:45:51.813165Z","end":"2026-05-27T13:45:52.588206Z","steps":["trace[565620194] 'process raft request' (duration: 774.429237ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:52.588444Z","caller":"traceutil/trace.go:171","msg":"trace[554616701] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"359.356266ms","start":"2026-05-27T13:45:52.229072Z","end":"2026-05-27T13:45:52.588428Z","steps":["trace[554616701] 'process raft request' (duration: 358.891404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:52.588474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:51.813139Z","time spent":"775.231937ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:52.588497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.537869ms","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-27T13:45:52.588662Z","caller":"traceutil/trace.go:171","msg":"trace[1774811492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2173; }","duration":"774.732374ms","start":"2026-05-27T13:45:51.813911Z","end":"2026-05-27T13:45:52.588643Z","steps":["trace[1774811492] 'agreement among raft nodes before linearized reading' (duration: 774.428177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:52.588693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.701785ms","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-27T13:45:52.588667Z","caller":"traceutil/trace.go:171","msg":"trace[399055994] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"774.781796ms","start":"2026-05-27T13:45:51.813106Z","end":"2026-05-27T13:45:52.587888Z","steps":["trace[399055994] 'process raft request' (duration: 488.025014ms)","trace[399055994] 'compare' (duration: 285.838369ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:52.588765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:51.813901Z","time spent":"774.810586ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:45:52.588741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.876904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-05-27T13:45:52.588868Z","caller":"traceutil/trace.go:171","msg":"trace[1259256742] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2173; }","duration":"211.054859ms","start":"2026-05-27T13:45:52.3778Z","end":"2026-05-27T13:45:52.588855Z","steps":["trace[1259256742] 'agreement among raft nodes before linearized reading' (duration: 210.832393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:52.588897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.549387ms","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":"info","ts":"2026-05-27T13:45:52.588953Z","caller":"traceutil/trace.go:171","msg":"trace[384993321] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:2173; }","duration":"451.609049ms","start":"2026-05-27T13:45:52.137332Z","end":"2026-05-27T13:45:52.588941Z","steps":["trace[384993321] 'agreement among raft nodes before linearized reading' (duration: 451.522007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:52.588557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.373858ms","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-27T13:45:52.589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:52.13729Z","time spent":"451.700291ms","remote":"127.0.0.1:55096","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":"info","ts":"2026-05-27T13:45:52.589039Z","caller":"traceutil/trace.go:171","msg":"trace[1625665260] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2173; }","duration":"276.904711ms","start":"2026-05-27T13:45:52.31212Z","end":"2026-05-27T13:45:52.589024Z","steps":["trace[1625665260] 'agreement among raft nodes before linearized reading' (duration: 276.279205ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:52.588796Z","caller":"traceutil/trace.go:171","msg":"trace[1104488175] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2173; }","duration":"769.864769ms","start":"2026-05-27T13:45:51.818907Z","end":"2026-05-27T13:45:52.588772Z","steps":["trace[1104488175] 'agreement among raft nodes before linearized reading' (duration: 769.49112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:52.589209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:51.818893Z","time spent":"770.249299ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:45:52.589043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:51.813082Z","time spent":"775.809291ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:52.589385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:52.229044Z","time spent":"359.446938ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:52.591196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.278428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b3701a8f5b015e\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-05-27T13:45:52.591266Z","caller":"traceutil/trace.go:171","msg":"trace[1560794096] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b3701a8f5b015e; range_end:; response_count:1; response_revision:2173; }","duration":"471.347869ms","start":"2026-05-27T13:45:52.119896Z","end":"2026-05-27T13:45:52.591244Z","steps":["trace[1560794096] 'agreement among raft nodes before linearized reading' (duration: 469.275007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:52.591395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:52.119852Z","time spent":"471.529735ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":870,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b3701a8f5b015e\" "} {"level":"warn","ts":"2026-05-27T13:45:53.098143Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532670288309428,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:45:53.309368Z","caller":"traceutil/trace.go:171","msg":"trace[182361205] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"716.006433ms","start":"2026-05-27T13:45:52.593332Z","end":"2026-05-27T13:45:53.309338Z","steps":["trace[182361205] 'process raft request' (duration: 715.844289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:53.309519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:52.593307Z","time spent":"716.135257ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:53.88123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.914842ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:45:53.881647Z","caller":"traceutil/trace.go:171","msg":"trace[210534771] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"1.287442046s","start":"2026-05-27T13:45:52.594177Z","end":"2026-05-27T13:45:53.881619Z","steps":["trace[210534771] 'process raft request' (duration: 1.287170409s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:53.881615Z","caller":"traceutil/trace.go:171","msg":"trace[127132302] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"1.28759457s","start":"2026-05-27T13:45:52.593985Z","end":"2026-05-27T13:45:53.88158Z","steps":["trace[127132302] 'process raft request' (duration: 849.219146ms)","trace[127132302] 'compare' (duration: 437.249744ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:53.881757Z","caller":"traceutil/trace.go:171","msg":"trace[1740927720] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"917.990174ms","start":"2026-05-27T13:45:52.96371Z","end":"2026-05-27T13:45:53.8817Z","steps":["trace[1740927720] 'process raft request' (duration: 917.815479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:53.881829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:52.593965Z","time spent":"1.287787695s","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:45:53.881741Z","caller":"traceutil/trace.go:171","msg":"trace[1025011111] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"1.287064487s","start":"2026-05-27T13:45:52.594633Z","end":"2026-05-27T13:45:53.881698Z","steps":["trace[1025011111] 'process raft request' (duration: 1.286845321s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:53.882015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:52.594164Z","time spent":"1.28758329s","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:53.881996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:52.96368Z","time spent":"918.188299ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:53.882291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:52.594623Z","time spent":"1.287441506s","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:45:53.88377Z","caller":"traceutil/trace.go:171","msg":"trace[1008112393] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"267.186016ms","start":"2026-05-27T13:45:53.616568Z","end":"2026-05-27T13:45:53.883754Z","steps":["trace[1008112393] 'process raft request' (duration: 267.017132ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:53.883997Z","caller":"traceutil/trace.go:171","msg":"trace[977216537] linearizableReadLoop","detail":"{readStateIndex:2262; appliedIndex:2257; }","duration":"1.286903832s","start":"2026-05-27T13:45:52.597005Z","end":"2026-05-27T13:45:53.883909Z","steps":["trace[977216537] 'read index received' (duration: 712.154586ms)","trace[977216537] 'applied index is now lower than readState.Index' (duration: 574.746836ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:53.884118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.287104748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:45:53.884157Z","caller":"traceutil/trace.go:171","msg":"trace[853617861] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2179; }","duration":"1.287149649s","start":"2026-05-27T13:45:52.596998Z","end":"2026-05-27T13:45:53.884147Z","steps":["trace[853617861] 'agreement among raft nodes before linearized reading' (duration: 1.287078037s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:53.884195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:52.59696Z","time spent":"1.287223911s","remote":"127.0.0.1:55426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-05-27T13:45:53.886626Z","caller":"traceutil/trace.go:171","msg":"trace[175603745] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"195.347931ms","start":"2026-05-27T13:45:53.691265Z","end":"2026-05-27T13:45:53.886613Z","steps":["trace[175603745] 'process raft request' (duration: 194.877878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:53.886619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.089946059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-27T13:45:53.886687Z","caller":"traceutil/trace.go:171","msg":"trace[1570668277] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2181; }","duration":"1.090066172s","start":"2026-05-27T13:45:52.796605Z","end":"2026-05-27T13:45:53.886672Z","steps":["trace[1570668277] 'agreement among raft nodes before linearized reading' (duration: 1.089754154s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:53.886808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.205108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:45:53.886913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.751874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:45:53.886946Z","caller":"traceutil/trace.go:171","msg":"trace[363553656] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2181; }","duration":"477.830096ms","start":"2026-05-27T13:45:53.409109Z","end":"2026-05-27T13:45:53.886939Z","steps":["trace[363553656] 'agreement among raft nodes before linearized reading' (duration: 477.771824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:53.886968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:53.409089Z","time spent":"477.874226ms","remote":"127.0.0.1:55284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":31,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"info","ts":"2026-05-27T13:45:53.886964Z","caller":"traceutil/trace.go:171","msg":"trace[1611803656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2181; }","duration":"199.470645ms","start":"2026-05-27T13:45:53.687467Z","end":"2026-05-27T13:45:53.886938Z","steps":["trace[1611803656] 'agreement among raft nodes before linearized reading' (duration: 199.183178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:53.886724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:52.796584Z","time spent":"1.090131054s","remote":"127.0.0.1:46866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-27T13:46:07.301385Z","caller":"traceutil/trace.go:171","msg":"trace[2041802878] transaction","detail":"{read_only:false; response_revision:2248; number_of_response:1; }","duration":"182.021383ms","start":"2026-05-27T13:46:07.119339Z","end":"2026-05-27T13:46:07.30136Z","steps":["trace[2041802878] 'process raft request' (duration: 181.864239ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:12.440945Z","caller":"traceutil/trace.go:171","msg":"trace[1111535627] transaction","detail":"{read_only:false; response_revision:2270; number_of_response:1; }","duration":"490.309795ms","start":"2026-05-27T13:46:11.950606Z","end":"2026-05-27T13:46:12.440915Z","steps":["trace[1111535627] 'process raft request' (duration: 490.075759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:12.441261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:11.950578Z","time spent":"490.609523ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:12.444905Z","caller":"traceutil/trace.go:171","msg":"trace[1425934133] linearizableReadLoop","detail":"{readStateIndex:2360; appliedIndex:2357; }","duration":"482.601559ms","start":"2026-05-27T13:46:11.962271Z","end":"2026-05-27T13:46:12.444872Z","steps":["trace[1425934133] 'read index received' (duration: 478.471505ms)","trace[1425934133] 'applied index is now lower than readState.Index' (duration: 4.128844ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:46:12.444941Z","caller":"traceutil/trace.go:171","msg":"trace[243722202] transaction","detail":"{read_only:false; response_revision:2271; number_of_response:1; }","duration":"492.197442ms","start":"2026-05-27T13:46:11.952713Z","end":"2026-05-27T13:46:12.444911Z","steps":["trace[243722202] 'process raft request' (duration: 492.021558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:12.445175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.902856ms","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-27T13:46:12.445208Z","caller":"traceutil/trace.go:171","msg":"trace[842012007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2272; }","duration":"482.944017ms","start":"2026-05-27T13:46:11.962255Z","end":"2026-05-27T13:46:12.445199Z","steps":["trace[842012007] 'agreement among raft nodes before linearized reading' (duration: 482.762803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:12.445246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:11.962213Z","time spent":"483.024839ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:46:12.44546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:11.952702Z","time spent":"492.481539ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:46:12.445478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.707062ms","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-27T13:46:12.444999Z","caller":"traceutil/trace.go:171","msg":"trace[1159809157] transaction","detail":"{read_only:false; response_revision:2272; number_of_response:1; }","duration":"486.698253ms","start":"2026-05-27T13:46:11.95829Z","end":"2026-05-27T13:46:12.444988Z","steps":["trace[1159809157] 'process raft request' (duration: 486.511888ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:12.445643Z","caller":"traceutil/trace.go:171","msg":"trace[493636066] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2272; }","duration":"482.859167ms","start":"2026-05-27T13:46:11.962723Z","end":"2026-05-27T13:46:12.445582Z","steps":["trace[493636066] 'agreement among raft nodes before linearized reading' (duration: 482.664672ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:12.445747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:11.962716Z","time spent":"483.0153ms","remote":"127.0.0.1:55250","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":"warn","ts":"2026-05-27T13:46:12.445795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.00648ms","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":"warn","ts":"2026-05-27T13:46:12.445643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:11.958275Z","time spent":"487.318099ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:12.445869Z","caller":"traceutil/trace.go:171","msg":"trace[1575135933] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2272; }","duration":"483.093453ms","start":"2026-05-27T13:46:11.962762Z","end":"2026-05-27T13:46:12.445856Z","steps":["trace[1575135933] 'agreement among raft nodes before linearized reading' (duration: 482.927568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:12.446039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:11.962757Z","time spent":"483.264607ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:46:12.445621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.556266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-27T13:46:12.446164Z","caller":"traceutil/trace.go:171","msg":"trace[1799919682] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2272; }","duration":"438.133731ms","start":"2026-05-27T13:46:12.008001Z","end":"2026-05-27T13:46:12.446135Z","steps":["trace[1799919682] 'agreement among raft nodes before linearized reading' (duration: 437.406992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:12.446233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:12.007986Z","time spent":"438.230973ms","remote":"127.0.0.1:46866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-27T13:46:12.446101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.422909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b3701a8f5b015e\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-05-27T13:46:12.446471Z","caller":"traceutil/trace.go:171","msg":"trace[1891630486] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b3701a8f5b015e; range_end:; response_count:1; response_revision:2272; }","duration":"333.83869ms","start":"2026-05-27T13:46:12.112615Z","end":"2026-05-27T13:46:12.446454Z","steps":["trace[1891630486] 'agreement among raft nodes before linearized reading' (duration: 333.015779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:12.446549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:12.112529Z","time spent":"334.010695ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":870,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b3701a8f5b015e\" "} {"level":"warn","ts":"2026-05-27T13:46:27.667873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.032763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-fqrn2\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-05-27T13:46:27.667962Z","caller":"traceutil/trace.go:171","msg":"trace[1629779855] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-fqrn2; range_end:; response_count:1; response_revision:2410; }","duration":"217.153557ms","start":"2026-05-27T13:46:27.450788Z","end":"2026-05-27T13:46:27.667942Z","steps":["trace[1629779855] 'range keys from in-memory index tree' (duration: 216.859549ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:09.573075Z","caller":"traceutil/trace.go:171","msg":"trace[283192410] transaction","detail":"{read_only:false; response_revision:2698; number_of_response:1; }","duration":"331.323951ms","start":"2026-05-27T13:47:09.24171Z","end":"2026-05-27T13:47:09.573034Z","steps":["trace[283192410] 'process raft request' (duration: 330.967044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:09.573439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:09.241683Z","time spent":"331.649777ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:47:10.900367Z","caller":"traceutil/trace.go:171","msg":"trace[118672379] linearizableReadLoop","detail":"{readStateIndex:2803; appliedIndex:2800; }","duration":"214.430234ms","start":"2026-05-27T13:47:10.685923Z","end":"2026-05-27T13:47:10.900354Z","steps":["trace[118672379] 'read index received' (duration: 45.902503ms)","trace[118672379] 'applied index is now lower than readState.Index' (duration: 168.526991ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:47:10.900507Z","caller":"traceutil/trace.go:171","msg":"trace[453166651] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"253.154407ms","start":"2026-05-27T13:47:10.647342Z","end":"2026-05-27T13:47:10.900497Z","steps":["trace[453166651] 'process raft request' (duration: 195.381509ms)","trace[453166651] 'compare' (duration: 57.514434ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:47:10.900655Z","caller":"traceutil/trace.go:171","msg":"trace[183247950] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"229.558749ms","start":"2026-05-27T13:47:10.671089Z","end":"2026-05-27T13:47:10.900648Z","steps":["trace[183247950] 'process raft request' (duration: 229.236973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:10.900866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.931373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:47:10.90108Z","caller":"traceutil/trace.go:171","msg":"trace[873658617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2702; }","duration":"215.032415ms","start":"2026-05-27T13:47:10.685881Z","end":"2026-05-27T13:47:10.900913Z","steps":["trace[873658617] 'agreement among raft nodes before linearized reading' (duration: 214.879942ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:10.904755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.593221ms","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-27T13:47:10.904957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.202226ms","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-27T13:47:10.905023Z","caller":"traceutil/trace.go:171","msg":"trace[291516876] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2703; }","duration":"130.283087ms","start":"2026-05-27T13:47:10.774731Z","end":"2026-05-27T13:47:10.905014Z","steps":["trace[291516876] 'agreement among raft nodes before linearized reading' (duration: 130.139214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:10.905414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.235904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-27T13:47:10.905512Z","caller":"traceutil/trace.go:171","msg":"trace[1343360521] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2703; }","duration":"131.304425ms","start":"2026-05-27T13:47:10.774159Z","end":"2026-05-27T13:47:10.905463Z","steps":["trace[1343360521] 'agreement among raft nodes before linearized reading' (duration: 131.143792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:10.905749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.070782ms","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-27T13:47:10.905801Z","caller":"traceutil/trace.go:171","msg":"trace[931539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2703; }","duration":"136.141773ms","start":"2026-05-27T13:47:10.769652Z","end":"2026-05-27T13:47:10.905793Z","steps":["trace[931539] 'agreement among raft nodes before linearized reading' (duration: 136.054411ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:10.904843Z","caller":"traceutil/trace.go:171","msg":"trace[1850918660] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2703; }","duration":"136.716883ms","start":"2026-05-27T13:47:10.768092Z","end":"2026-05-27T13:47:10.904809Z","steps":["trace[1850918660] 'agreement among raft nodes before linearized reading' (duration: 136.592431ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:13.675519Z","caller":"traceutil/trace.go:171","msg":"trace[814770019] transaction","detail":"{read_only:false; response_revision:3828; number_of_response:1; }","duration":"115.685425ms","start":"2026-05-27T13:50:13.559804Z","end":"2026-05-27T13:50:13.675489Z","steps":["trace[814770019] 'process raft request' (duration: 115.45192ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:13.678283Z","caller":"traceutil/trace.go:171","msg":"trace[482124587] transaction","detail":"{read_only:false; response_revision:3829; number_of_response:1; }","duration":"105.315979ms","start":"2026-05-27T13:50:13.572933Z","end":"2026-05-27T13:50:13.678249Z","steps":["trace[482124587] 'process raft request' (duration: 105.093494ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:13.678476Z","caller":"traceutil/trace.go:171","msg":"trace[148879829] transaction","detail":"{read_only:false; response_revision:3830; number_of_response:1; }","duration":"101.578282ms","start":"2026-05-27T13:50:13.57688Z","end":"2026-05-27T13:50:13.678458Z","steps":["trace[148879829] 'process raft request' (duration: 101.285246ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:47.892912Z","caller":"traceutil/trace.go:171","msg":"trace[875973741] transaction","detail":"{read_only:false; response_revision:4395; number_of_response:1; }","duration":"121.213146ms","start":"2026-05-27T13:50:47.771675Z","end":"2026-05-27T13:50:47.892888Z","steps":["trace[875973741] 'process raft request' (duration: 120.9994ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:47.893256Z","caller":"traceutil/trace.go:171","msg":"trace[923092570] transaction","detail":"{read_only:false; response_revision:4396; number_of_response:1; }","duration":"121.523543ms","start":"2026-05-27T13:50:47.771718Z","end":"2026-05-27T13:50:47.893242Z","steps":["trace[923092570] 'process raft request' (duration: 121.127124ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:47.893352Z","caller":"traceutil/trace.go:171","msg":"trace[1189313808] transaction","detail":"{read_only:false; response_revision:4397; number_of_response:1; }","duration":"121.238397ms","start":"2026-05-27T13:50:47.77205Z","end":"2026-05-27T13:50:47.893288Z","steps":["trace[1189313808] 'process raft request' (duration: 121.039952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:51.292133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.559175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1d69f1a2-b83c-458c-aeaf-95e0a64f83e3\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-05-27T13:50:51.292229Z","caller":"traceutil/trace.go:171","msg":"trace[1558541252] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1d69f1a2-b83c-458c-aeaf-95e0a64f83e3; range_end:; response_count:1; response_revision:4511; }","duration":"174.683568ms","start":"2026-05-27T13:50:51.117516Z","end":"2026-05-27T13:50:51.292199Z","steps":["trace[1558541252] 'range keys from in-memory index tree' (duration: 174.406921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:51.910445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.0477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-05-27T13:50:51.910523Z","caller":"traceutil/trace.go:171","msg":"trace[1388495144] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4519; }","duration":"188.177913ms","start":"2026-05-27T13:50:51.72233Z","end":"2026-05-27T13:50:51.910508Z","steps":["trace[1388495144] 'range keys from in-memory index tree' (duration: 187.829085ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:53.964658Z","caller":"traceutil/trace.go:171","msg":"trace[840016221] transaction","detail":"{read_only:false; response_revision:4544; number_of_response:1; }","duration":"164.827661ms","start":"2026-05-27T13:50:53.799798Z","end":"2026-05-27T13:50:53.964626Z","steps":["trace[840016221] 'process raft request' (duration: 164.497553ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:55.190694Z","caller":"traceutil/trace.go:171","msg":"trace[828165372] transaction","detail":"{read_only:false; response_revision:4594; number_of_response:1; }","duration":"112.308536ms","start":"2026-05-27T13:50:55.078366Z","end":"2026-05-27T13:50:55.190675Z","steps":["trace[828165372] 'process raft request' (duration: 112.087741ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:01.121215Z","caller":"traceutil/trace.go:171","msg":"trace[765440341] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"393.502668ms","start":"2026-05-27T13:51:00.727688Z","end":"2026-05-27T13:51:01.12119Z","steps":["trace[765440341] 'process raft request' (duration: 393.300883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:01.121378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:00.727675Z","time spent":"393.62166ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:51:01.518593Z","caller":"traceutil/trace.go:171","msg":"trace[1080120541] linearizableReadLoop","detail":"{readStateIndex:4829; appliedIndex:4827; }","duration":"692.915722ms","start":"2026-05-27T13:51:00.825657Z","end":"2026-05-27T13:51:01.518573Z","steps":["trace[1080120541] 'read index received' (duration: 295.333758ms)","trace[1080120541] 'applied index is now lower than readState.Index' (duration: 397.581034ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:01.518747Z","caller":"traceutil/trace.go:171","msg":"trace[241734393] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"786.143437ms","start":"2026-05-27T13:51:00.732591Z","end":"2026-05-27T13:51:01.518734Z","steps":["trace[241734393] 'process raft request' (duration: 785.840839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:01.518872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.943074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-27T13:51:01.518899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:00.732582Z","time spent":"786.228698ms","remote":"127.0.0.1:55156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13278,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:51:01.518941Z","caller":"traceutil/trace.go:171","msg":"trace[1551237145] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:4651; }","duration":"302.060577ms","start":"2026-05-27T13:51:01.216862Z","end":"2026-05-27T13:51:01.518923Z","steps":["trace[1551237145] 'agreement among raft nodes before linearized reading' (duration: 301.920484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:01.518974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:01.21681Z","time spent":"302.155069ms","remote":"127.0.0.1:54782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":31,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:51:01.519002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.324622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-27T13:51:01.519083Z","caller":"traceutil/trace.go:171","msg":"trace[1530600911] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4651; }","duration":"693.441495ms","start":"2026-05-27T13:51:00.82562Z","end":"2026-05-27T13:51:01.519062Z","steps":["trace[1530600911] 'agreement among raft nodes before linearized reading' (duration: 693.23044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:01.519129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:00.825606Z","time spent":"693.513307ms","remote":"127.0.0.1:55120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1959,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-05-27T13:51:02.248974Z","caller":"traceutil/trace.go:171","msg":"trace[937438248] transaction","detail":"{read_only:false; response_revision:4659; number_of_response:1; }","duration":"256.539262ms","start":"2026-05-27T13:51:01.992396Z","end":"2026-05-27T13:51:02.248935Z","steps":["trace[937438248] 'process raft request' (duration: 163.968612ms)","trace[937438248] 'compare' (duration: 92.034927ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:02.273737Z","caller":"traceutil/trace.go:171","msg":"trace[584314118] linearizableReadLoop","detail":"{readStateIndex:4839; appliedIndex:4836; }","duration":"180.966032ms","start":"2026-05-27T13:51:02.092758Z","end":"2026-05-27T13:51:02.273724Z","steps":["trace[584314118] 'read index received' (duration: 63.622652ms)","trace[584314118] 'applied index is now lower than readState.Index' (duration: 117.34284ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:02.273767Z","caller":"traceutil/trace.go:171","msg":"trace[1794554423] transaction","detail":"{read_only:false; response_revision:4660; number_of_response:1; }","duration":"254.854603ms","start":"2026-05-27T13:51:02.018886Z","end":"2026-05-27T13:51:02.273741Z","steps":["trace[1794554423] 'process raft request' (duration: 254.745521ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:02.273931Z","caller":"traceutil/trace.go:171","msg":"trace[1827508368] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"254.682919ms","start":"2026-05-27T13:51:02.019235Z","end":"2026-05-27T13:51:02.273918Z","steps":["trace[1827508368] 'process raft request' (duration: 254.467874ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:02.27401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.223658ms","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-27T13:51:02.274089Z","caller":"traceutil/trace.go:171","msg":"trace[221475289] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4661; }","duration":"181.345271ms","start":"2026-05-27T13:51:02.092725Z","end":"2026-05-27T13:51:02.27407Z","steps":["trace[221475289] 'agreement among raft nodes before linearized reading' (duration: 181.080305ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:02.472506Z","caller":"traceutil/trace.go:171","msg":"trace[155382184] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"193.646218ms","start":"2026-05-27T13:51:02.278826Z","end":"2026-05-27T13:51:02.472472Z","steps":["trace[155382184] 'process raft request' (duration: 133.927789ms)","trace[155382184] 'compare' (duration: 59.440702ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:02.473231Z","caller":"traceutil/trace.go:171","msg":"trace[1139270637] linearizableReadLoop","detail":"{readStateIndex:4842; appliedIndex:4839; }","duration":"146.943283ms","start":"2026-05-27T13:51:02.326273Z","end":"2026-05-27T13:51:02.473216Z","steps":["trace[1139270637] 'read index received' (duration: 86.537938ms)","trace[1139270637] 'applied index is now lower than readState.Index' (duration: 60.404505ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:02.473415Z","caller":"traceutil/trace.go:171","msg":"trace[885393059] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"193.091265ms","start":"2026-05-27T13:51:02.280311Z","end":"2026-05-27T13:51:02.473402Z","steps":["trace[885393059] 'process raft request' (duration: 192.818399ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:02.473645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.357573ms","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-27T13:51:02.473745Z","caller":"traceutil/trace.go:171","msg":"trace[907879771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4664; }","duration":"147.503357ms","start":"2026-05-27T13:51:02.32622Z","end":"2026-05-27T13:51:02.473724Z","steps":["trace[907879771] 'agreement among raft nodes before linearized reading' (duration: 147.281452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:02.473664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.222001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-27T13:51:02.47381Z","caller":"traceutil/trace.go:171","msg":"trace[241490599] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4664; }","duration":"124.415505ms","start":"2026-05-27T13:51:02.34938Z","end":"2026-05-27T13:51:02.473796Z","steps":["trace[241490599] 'agreement among raft nodes before linearized reading' (duration: 124.136579ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:02.473322Z","caller":"traceutil/trace.go:171","msg":"trace[1818567057] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"194.218162ms","start":"2026-05-27T13:51:02.279076Z","end":"2026-05-27T13:51:02.473295Z","steps":["trace[1818567057] 'process raft request' (duration: 193.357002ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:02.841691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.0976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:51:02.841792Z","caller":"traceutil/trace.go:171","msg":"trace[1785537994] linearizableReadLoop","detail":"{readStateIndex:4844; appliedIndex:4843; }","duration":"223.993879ms","start":"2026-05-27T13:51:02.617783Z","end":"2026-05-27T13:51:02.841777Z","steps":["trace[1785537994] 'read index received' (duration: 62.061µs)","trace[1785537994] 'applied index is now lower than readState.Index' (duration: 223.930228ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:02.84189Z","caller":"traceutil/trace.go:171","msg":"trace[1533830735] transaction","detail":"{read_only:false; response_revision:4666; number_of_response:1; }","duration":"363.907439ms","start":"2026-05-27T13:51:02.477972Z","end":"2026-05-27T13:51:02.841879Z","steps":["trace[1533830735] 'process raft request' (duration: 119.547802ms)","trace[1533830735] 'compare' (duration: 244.003048ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:51:02.841945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:02.477957Z","time spent":"363.957869ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:51:02.842084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.201284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:51:02.842211Z","caller":"traceutil/trace.go:171","msg":"trace[1051895756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4666; }","duration":"154.338607ms","start":"2026-05-27T13:51:02.687815Z","end":"2026-05-27T13:51:02.842154Z","steps":["trace[1051895756] 'agreement among raft nodes before linearized reading' (duration: 154.200874ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:02.842623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.586184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16232"} {"level":"info","ts":"2026-05-27T13:51:02.842674Z","caller":"traceutil/trace.go:171","msg":"trace[1738313486] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4666; }","duration":"102.664677ms","start":"2026-05-27T13:51:02.739994Z","end":"2026-05-27T13:51:02.842658Z","steps":["trace[1738313486] 'agreement among raft nodes before linearized reading' (duration: 102.487813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:02.842294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.518702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:51:02.843414Z","caller":"traceutil/trace.go:171","msg":"trace[193424421] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4666; }","duration":"225.671429ms","start":"2026-05-27T13:51:02.617727Z","end":"2026-05-27T13:51:02.843398Z","steps":["trace[193424421] 'agreement among raft nodes before linearized reading' (duration: 224.534702ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:04.916595Z","caller":"traceutil/trace.go:171","msg":"trace[1094174518] linearizableReadLoop","detail":"{readStateIndex:4868; appliedIndex:4867; }","duration":"229.915822ms","start":"2026-05-27T13:51:04.68665Z","end":"2026-05-27T13:51:04.916566Z","steps":["trace[1094174518] 'read index received' (duration: 229.732947ms)","trace[1094174518] 'applied index is now lower than readState.Index' (duration: 181.555µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:04.916715Z","caller":"traceutil/trace.go:171","msg":"trace[1614760093] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"272.875389ms","start":"2026-05-27T13:51:04.643829Z","end":"2026-05-27T13:51:04.916704Z","steps":["trace[1614760093] 'process raft request' (duration: 272.593822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:04.916931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.271452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:51:04.91697Z","caller":"traceutil/trace.go:171","msg":"trace[1080854852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4689; }","duration":"230.349563ms","start":"2026-05-27T13:51:04.686611Z","end":"2026-05-27T13:51:04.916961Z","steps":["trace[1080854852] 'agreement among raft nodes before linearized reading' (duration: 230.277871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:04.917222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.909824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:51:04.917291Z","caller":"traceutil/trace.go:171","msg":"trace[2016873356] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4689; }","duration":"193.024387ms","start":"2026-05-27T13:51:04.724248Z","end":"2026-05-27T13:51:04.917272Z","steps":["trace[2016873356] 'agreement among raft nodes before linearized reading' (duration: 192.905834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:04.917551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.674724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-wsvck\" ","response":"range_response_count:1 size:9942"} {"level":"info","ts":"2026-05-27T13:51:04.917577Z","caller":"traceutil/trace.go:171","msg":"trace[1885763097] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-wsvck; range_end:; response_count:1; response_revision:4689; }","duration":"156.765557ms","start":"2026-05-27T13:51:04.760803Z","end":"2026-05-27T13:51:04.917569Z","steps":["trace[1885763097] 'agreement among raft nodes before linearized reading' (duration: 156.649404ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:06.536947Z","caller":"traceutil/trace.go:171","msg":"trace[727377435] linearizableReadLoop","detail":"{readStateIndex:4937; appliedIndex:4935; }","duration":"218.072588ms","start":"2026-05-27T13:51:06.318851Z","end":"2026-05-27T13:51:06.536924Z","steps":["trace[727377435] 'read index received' (duration: 217.571117ms)","trace[727377435] 'applied index is now lower than readState.Index' (duration: 500.701µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:06.537008Z","caller":"traceutil/trace.go:171","msg":"trace[566550243] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"252.389133ms","start":"2026-05-27T13:51:06.28458Z","end":"2026-05-27T13:51:06.53697Z","steps":["trace[566550243] 'process raft request' (duration: 251.918522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:06.537189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.316594ms","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-27T13:51:06.537274Z","caller":"traceutil/trace.go:171","msg":"trace[911599683] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4758; }","duration":"218.431126ms","start":"2026-05-27T13:51:06.318826Z","end":"2026-05-27T13:51:06.537257Z","steps":["trace[911599683] 'agreement among raft nodes before linearized reading' (duration: 218.210881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:06.537365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.947387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:51:06.537451Z","caller":"traceutil/trace.go:171","msg":"trace[59849025] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:4758; }","duration":"216.084541ms","start":"2026-05-27T13:51:06.321348Z","end":"2026-05-27T13:51:06.537433Z","steps":["trace[59849025] 'agreement among raft nodes before linearized reading' (duration: 215.919817ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:06.537048Z","caller":"traceutil/trace.go:171","msg":"trace[330932432] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"247.888268ms","start":"2026-05-27T13:51:06.289129Z","end":"2026-05-27T13:51:06.537017Z","steps":["trace[330932432] 'process raft request' (duration: 247.757035ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:08.454961Z","caller":"traceutil/trace.go:171","msg":"trace[217165607] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"641.662788ms","start":"2026-05-27T13:51:07.813238Z","end":"2026-05-27T13:51:08.454901Z","steps":["trace[217165607] 'process raft request' (duration: 584.843763ms)","trace[217165607] 'compare' (duration: 56.486397ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:51:08.455138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:07.813212Z","time spent":"641.827773ms","remote":"127.0.0.1:54996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:51:08.455151Z","caller":"traceutil/trace.go:171","msg":"trace[1574740266] transaction","detail":"{read_only:false; response_revision:4768; number_of_response:1; }","duration":"136.714501ms","start":"2026-05-27T13:51:08.31838Z","end":"2026-05-27T13:51:08.455094Z","steps":["trace[1574740266] 'process raft request' (duration: 136.541417ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:08.455507Z","caller":"traceutil/trace.go:171","msg":"trace[623318541] linearizableReadLoop","detail":"{readStateIndex:4947; appliedIndex:4946; }","duration":"172.953342ms","start":"2026-05-27T13:51:08.282539Z","end":"2026-05-27T13:51:08.455492Z","steps":["trace[623318541] 'read index received' (duration: 115.606695ms)","trace[623318541] 'applied index is now lower than readState.Index' (duration: 57.345267ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:51:08.455646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.095165ms","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":"info","ts":"2026-05-27T13:51:08.455684Z","caller":"traceutil/trace.go:171","msg":"trace[760658266] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:4768; }","duration":"173.188517ms","start":"2026-05-27T13:51:08.282487Z","end":"2026-05-27T13:51:08.455675Z","steps":["trace[760658266] 'agreement among raft nodes before linearized reading' (duration: 173.104125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:08.456202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.175421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e71e0104-d931-47e1-89c8-14d5461117a8\" ","response":"range_response_count:1 size:3939"} {"level":"info","ts":"2026-05-27T13:51:08.456253Z","caller":"traceutil/trace.go:171","msg":"trace[707696278] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e71e0104-d931-47e1-89c8-14d5461117a8; range_end:; response_count:1; response_revision:4768; }","duration":"134.58346ms","start":"2026-05-27T13:51:08.321658Z","end":"2026-05-27T13:51:08.456241Z","steps":["trace[707696278] 'agreement among raft nodes before linearized reading' (duration: 133.989377ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:09.227516Z","caller":"traceutil/trace.go:171","msg":"trace[262084507] transaction","detail":"{read_only:false; response_revision:4786; number_of_response:1; }","duration":"126.224756ms","start":"2026-05-27T13:51:09.101262Z","end":"2026-05-27T13:51:09.227487Z","steps":["trace[262084507] 'process raft request' (duration: 125.727904ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:09.22988Z","caller":"traceutil/trace.go:171","msg":"trace[1638978494] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"107.335642ms","start":"2026-05-27T13:51:09.12252Z","end":"2026-05-27T13:51:09.229855Z","steps":["trace[1638978494] 'process raft request' (duration: 107.204888ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:12.772458Z","caller":"traceutil/trace.go:171","msg":"trace[636268819] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"204.674593ms","start":"2026-05-27T13:51:12.567766Z","end":"2026-05-27T13:51:12.772441Z","steps":["trace[636268819] 'process raft request' (duration: 204.53621ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:12.902859Z","caller":"traceutil/trace.go:171","msg":"trace[626348883] linearizableReadLoop","detail":"{readStateIndex:5040; appliedIndex:5038; }","duration":"326.098317ms","start":"2026-05-27T13:51:12.576735Z","end":"2026-05-27T13:51:12.902833Z","steps":["trace[626348883] 'read index received' (duration: 195.591069ms)","trace[626348883] 'applied index is now lower than readState.Index' (duration: 130.505808ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:12.902918Z","caller":"traceutil/trace.go:171","msg":"trace[1159199792] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"331.152247ms","start":"2026-05-27T13:51:12.571745Z","end":"2026-05-27T13:51:12.902897Z","steps":["trace[1159199792] 'process raft request' (duration: 233.47619ms)","trace[1159199792] 'compare' (duration: 97.451892ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:51:12.903014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:12.571721Z","time spent":"331.233008ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:51:12.903052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.153148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:51:12.903113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.558256ms","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-27T13:51:12.903127Z","caller":"traceutil/trace.go:171","msg":"trace[1934588584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4857; }","duration":"215.276121ms","start":"2026-05-27T13:51:12.687834Z","end":"2026-05-27T13:51:12.90311Z","steps":["trace[1934588584] 'agreement among raft nodes before linearized reading' (duration: 215.167748ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:12.903151Z","caller":"traceutil/trace.go:171","msg":"trace[603612214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4857; }","duration":"325.619256ms","start":"2026-05-27T13:51:12.577521Z","end":"2026-05-27T13:51:12.90314Z","steps":["trace[603612214] 'agreement among raft nodes before linearized reading' (duration: 325.469993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:12.903184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:12.577512Z","time spent":"325.664857ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:51:12.903328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.566758ms","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-27T13:51:12.903387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.129898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-27T13:51:12.903414Z","caller":"traceutil/trace.go:171","msg":"trace[144183707] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4857; }","duration":"326.688281ms","start":"2026-05-27T13:51:12.576703Z","end":"2026-05-27T13:51:12.903391Z","steps":["trace[144183707] 'agreement among raft nodes before linearized reading' (duration: 326.238871ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:12.903436Z","caller":"traceutil/trace.go:171","msg":"trace[1034299606] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4857; }","duration":"323.176699ms","start":"2026-05-27T13:51:12.580249Z","end":"2026-05-27T13:51:12.903426Z","steps":["trace[1034299606] 'agreement among raft nodes before linearized reading' (duration: 323.074237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:12.903468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:12.580212Z","time spent":"323.246341ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:51:12.90347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.24524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-27T13:51:12.90347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:12.576691Z","time spent":"326.766223ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T13:51:12.903509Z","caller":"traceutil/trace.go:171","msg":"trace[1894917664] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4857; }","duration":"323.303353ms","start":"2026-05-27T13:51:12.580196Z","end":"2026-05-27T13:51:12.903499Z","steps":["trace[1894917664] 'agreement among raft nodes before linearized reading' (duration: 323.20617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:12.90354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:12.580185Z","time spent":"323.347294ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-27T13:51:17.983916Z","caller":"traceutil/trace.go:171","msg":"trace[1657935070] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"211.427948ms","start":"2026-05-27T13:51:17.772456Z","end":"2026-05-27T13:51:17.983884Z","steps":["trace[1657935070] 'process raft request' (duration: 211.168892ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:53.260533Z","caller":"traceutil/trace.go:171","msg":"trace[328409882] linearizableReadLoop","detail":"{readStateIndex:5408; appliedIndex:5404; }","duration":"130.260597ms","start":"2026-05-27T13:51:53.130241Z","end":"2026-05-27T13:51:53.260502Z","steps":["trace[328409882] 'read index received' (duration: 37.237175ms)","trace[328409882] 'applied index is now lower than readState.Index' (duration: 93.021902ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:51:53.260788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.524903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-27T13:51:53.260878Z","caller":"traceutil/trace.go:171","msg":"trace[409717400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5215; }","duration":"130.664877ms","start":"2026-05-27T13:51:53.1302Z","end":"2026-05-27T13:51:53.260865Z","steps":["trace[409717400] 'agreement among raft nodes before linearized reading' (duration: 130.411301ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:26.41022Z","caller":"traceutil/trace.go:171","msg":"trace[1773278857] transaction","detail":"{read_only:false; response_revision:5444; number_of_response:1; }","duration":"117.4177ms","start":"2026-05-27T13:52:26.292762Z","end":"2026-05-27T13:52:26.41018Z","steps":["trace[1773278857] 'process raft request' (duration: 117.026421ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:32.607428Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2815} {"level":"info","ts":"2026-05-27T13:52:32.722635Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2815,"took":"114.071472ms","hash":1121134627,"current-db-size-bytes":52219904,"current-db-size":"52 MB","current-db-size-in-use-bytes":28987392,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-27T13:52:32.722713Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1121134627,"revision":2815,"compact-revision":-1} {"level":"warn","ts":"2026-05-27T13:55:47.190068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.831576ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:55:47.190424Z","caller":"traceutil/trace.go:171","msg":"trace[751778653] linearizableReadLoop","detail":"{readStateIndex:7045; appliedIndex:7043; }","duration":"683.940961ms","start":"2026-05-27T13:55:46.50647Z","end":"2026-05-27T13:55:47.190411Z","steps":["trace[751778653] 'read index received' (duration: 80.381429ms)","trace[751778653] 'applied index is now lower than readState.Index' (duration: 603.558492ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:55:47.190502Z","caller":"traceutil/trace.go:171","msg":"trace[1981029096] transaction","detail":"{read_only:false; response_revision:6796; number_of_response:1; }","duration":"697.06568ms","start":"2026-05-27T13:55:46.493424Z","end":"2026-05-27T13:55:47.190489Z","steps":["trace[1981029096] 'process raft request' (duration: 181.774323ms)","trace[1981029096] 'compare' (duration: 514.463827ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:55:47.19059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:46.493398Z","time spent":"697.165632ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:55:47.190692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.201557ms","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-27T13:55:47.190751Z","caller":"traceutil/trace.go:171","msg":"trace[2098950677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6796; }","duration":"684.29431ms","start":"2026-05-27T13:55:46.506443Z","end":"2026-05-27T13:55:47.190737Z","steps":["trace[2098950677] 'agreement among raft nodes before linearized reading' (duration: 684.089435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:47.190778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:46.506423Z","time spent":"684.350891ms","remote":"127.0.0.1:55250","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-27T13:55:47.207355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.352437ms","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-27T13:55:47.207491Z","caller":"traceutil/trace.go:171","msg":"trace[2032224223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6797; }","duration":"697.51601ms","start":"2026-05-27T13:55:46.509956Z","end":"2026-05-27T13:55:47.207472Z","steps":["trace[2032224223] 'agreement among raft nodes before linearized reading' (duration: 697.261024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:47.207564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:46.509943Z","time spent":"697.608732ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:55:47.2079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.021494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-27T13:55:47.207929Z","caller":"traceutil/trace.go:171","msg":"trace[39129511] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6797; }","duration":"694.052314ms","start":"2026-05-27T13:55:46.51387Z","end":"2026-05-27T13:55:47.207922Z","steps":["trace[39129511] 'agreement among raft nodes before linearized reading' (duration: 693.973032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:47.207948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:46.513838Z","time spent":"694.105156ms","remote":"127.0.0.1:55250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:55:47.208085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.074614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:55:47.208108Z","caller":"traceutil/trace.go:171","msg":"trace[477919577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6797; }","duration":"696.098015ms","start":"2026-05-27T13:55:46.512004Z","end":"2026-05-27T13:55:47.208102Z","steps":["trace[477919577] 'agreement among raft nodes before linearized reading' (duration: 696.061494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:47.208124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:46.511947Z","time spent":"696.173236ms","remote":"127.0.0.1:54970","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-27T13:55:47.208571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.620244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:55:47.208856Z","caller":"traceutil/trace.go:171","msg":"trace[18523646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6797; }","duration":"521.910872ms","start":"2026-05-27T13:55:46.686903Z","end":"2026-05-27T13:55:47.208813Z","steps":["trace[18523646] 'agreement among raft nodes before linearized reading' (duration: 521.643085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:47.21017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:46.686881Z","time spent":"523.273816ms","remote":"127.0.0.1:54986","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-27T13:55:47.208436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.127417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:25 size:449697"} {"level":"info","ts":"2026-05-27T13:55:47.210774Z","caller":"traceutil/trace.go:171","msg":"trace[1954703459] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:25; response_revision:6797; }","duration":"632.465745ms","start":"2026-05-27T13:55:46.578294Z","end":"2026-05-27T13:55:47.21076Z","steps":["trace[1954703459] 'agreement among raft nodes before linearized reading' (duration: 629.539952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:47.21084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:46.57825Z","time spent":"632.574948ms","remote":"127.0.0.1:55066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":25,"response size":449721,"request content":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" "} {"level":"info","ts":"2026-05-27T13:57:32.613218Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5502} {"level":"info","ts":"2026-05-27T13:57:32.706064Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5502,"took":"90.787145ms","hash":2768051238,"current-db-size-bytes":52219904,"current-db-size":"52 MB","current-db-size-in-use-bytes":18452480,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-27T13:57:32.706121Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2768051238,"revision":5502,"compact-revision":2815}