{"level":"warn","ts":"2026-08-13T08:35:04.502938Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T08:35:04.503021Z","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-08-13T08:35:04.503077Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T08:35:04.503086Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-08-13T08:35:04.503103Z","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-08-13T08:35:04.503696Z","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-08-13T08:35:04.503765Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.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-08-13T08:35:04.509208Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.257237ms"} {"level":"info","ts":"2026-08-13T08:35:04.516258Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-08-13T08:35:04.51637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T08:35:04.516411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-08-13T08:35:04.516427Z","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-08-13T08:35:04.516448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-08-13T08:35:04.516503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-08-13T08:35:04.533229Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T08:35:04.53501Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T08:35:04.536872Z","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-08-13T08:35:04.539363Z","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-08-13T08:35:04.54004Z","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-08-13T08:35:04.54015Z","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-08-13T08:35:04.540602Z","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-08-13T08:35:04.540804Z","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-08-13T08:35:04.544608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-08-13T08:35:04.544809Z","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-08-13T08:35:04.546153Z","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-08-13T08:35:04.546324Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-08-13T08:35:04.546385Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-08-13T08:35:04.547398Z","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-08-13T08:35:04.547475Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T08:35:05.217385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T08:35:05.217464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T08:35:05.217509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-08-13T08:35:05.21753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-08-13T08:35:05.217555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-08-13T08:35:05.217604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-08-13T08:35:05.217623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-08-13T08:35:05.218854Z","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-08-13T08:35:05.218902Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T08:35:05.218928Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:35:05.219298Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T08:35:05.221016Z","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-08-13T08:35:05.221172Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:35:05.221214Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:35:05.221943Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T08:35:05.222153Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T08:35:05.222187Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T08:35:05.222514Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-08-13T08:35:24.689756Z","caller":"traceutil/trace.go:171","msg":"trace[751701930] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"160.149236ms","start":"2026-08-13T08:35:24.529581Z","end":"2026-08-13T08:35:24.68973Z","steps":["trace[751701930] 'process raft request' (duration: 159.920869ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:25.302638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.961638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-13T08:35:25.302814Z","caller":"traceutil/trace.go:171","msg":"trace[1669614119] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:416; }","duration":"213.190444ms","start":"2026-08-13T08:35:25.089599Z","end":"2026-08-13T08:35:25.30279Z","steps":["trace[1669614119] 'range keys from in-memory index tree' (duration: 212.845556ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:25.302819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.761903ms","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-08-13T08:35:25.302834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.601561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-13T08:35:25.302917Z","caller":"traceutil/trace.go:171","msg":"trace[180368177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:416; }","duration":"262.884016ms","start":"2026-08-13T08:35:25.040016Z","end":"2026-08-13T08:35:25.3029Z","steps":["trace[180368177] 'range keys from in-memory index tree' (duration: 262.62507ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:35:25.302962Z","caller":"traceutil/trace.go:171","msg":"trace[1996050839] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:416; }","duration":"269.806627ms","start":"2026-08-13T08:35:25.033129Z","end":"2026-08-13T08:35:25.302936Z","steps":["trace[1996050839] 'range keys from in-memory index tree' (duration: 269.472508ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:35:30.865395Z","caller":"traceutil/trace.go:171","msg":"trace[727782538] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"146.444558ms","start":"2026-08-13T08:35:30.718906Z","end":"2026-08-13T08:35:30.86535Z","steps":["trace[727782538] 'process raft request' (duration: 146.216483ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:35:30.936973Z","caller":"traceutil/trace.go:171","msg":"trace[1621795651] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"210.737011ms","start":"2026-08-13T08:35:30.726197Z","end":"2026-08-13T08:35:30.936934Z","steps":["trace[1621795651] 'process raft request' (duration: 210.056613ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:35:43.509573Z","caller":"traceutil/trace.go:171","msg":"trace[1378613954] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"108.114062ms","start":"2026-08-13T08:35:43.401432Z","end":"2026-08-13T08:35:43.509546Z","steps":["trace[1378613954] 'process raft request' (duration: 107.940558ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:35:43.845292Z","caller":"traceutil/trace.go:171","msg":"trace[2013899849] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"442.066537ms","start":"2026-08-13T08:35:43.403206Z","end":"2026-08-13T08:35:43.845273Z","steps":["trace[2013899849] 'process raft request' (duration: 441.79734ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:35:43.845305Z","caller":"traceutil/trace.go:171","msg":"trace[980944415] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"441.002889ms","start":"2026-08-13T08:35:43.404282Z","end":"2026-08-13T08:35:43.845285Z","steps":["trace[980944415] 'process raft request' (duration: 440.939197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:43.845804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:43.403192Z","time spent":"442.167559ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:35:43.845847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:43.404272Z","time spent":"441.108741ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:35:43.851846Z","caller":"traceutil/trace.go:171","msg":"trace[178939291] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:540; }","duration":"270.65541ms","start":"2026-08-13T08:35:43.581173Z","end":"2026-08-13T08:35:43.851829Z","steps":["trace[178939291] 'read index received' (duration: 263.813431ms)","trace[178939291] 'applied index is now lower than readState.Index' (duration: 6.840549ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:35:43.851987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.762072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:35:43.852025Z","caller":"traceutil/trace.go:171","msg":"trace[1584966160] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:525; }","duration":"270.858255ms","start":"2026-08-13T08:35:43.581156Z","end":"2026-08-13T08:35:43.852015Z","steps":["trace[1584966160] 'agreement among raft nodes before linearized reading' (duration: 270.740222ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:35:50.778803Z","caller":"traceutil/trace.go:171","msg":"trace[1677168440] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"196.455509ms","start":"2026-08-13T08:35:50.58232Z","end":"2026-08-13T08:35:50.778775Z","steps":["trace[1677168440] 'process raft request' (duration: 195.914205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:51.573814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.678227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:35:51.57403Z","caller":"traceutil/trace.go:171","msg":"trace[558193822] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"304.758785ms","start":"2026-08-13T08:35:51.269207Z","end":"2026-08-13T08:35:51.573965Z","steps":["trace[558193822] 'read index received' (duration: 32.901µs)","trace[558193822] 'applied index is now lower than readState.Index' (duration: 304.724364ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:35:51.574019Z","caller":"traceutil/trace.go:171","msg":"trace[2106172406] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"578.241348ms","start":"2026-08-13T08:35:50.995729Z","end":"2026-08-13T08:35:51.57397Z","steps":["trace[2106172406] 'process raft request' (duration: 136.057568ms)","trace[2106172406] 'compare' (duration: 441.429341ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:35:51.574256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.050072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5k5nh\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-13T08:35:51.574256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:50.995709Z","time spent":"578.404472ms","remote":"127.0.0.1:43778","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-08-13T08:35:51.574286Z","caller":"traceutil/trace.go:171","msg":"trace[439010238] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5k5nh; range_end:; response_count:1; response_revision:634; }","duration":"305.115554ms","start":"2026-08-13T08:35:51.26916Z","end":"2026-08-13T08:35:51.574276Z","steps":["trace[439010238] 'agreement among raft nodes before linearized reading' (duration: 304.9503ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:51.57433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:51.269142Z","time spent":"305.178225ms","remote":"127.0.0.1:43704","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-5k5nh\" "} {"level":"info","ts":"2026-08-13T08:35:51.771413Z","caller":"traceutil/trace.go:171","msg":"trace[1827753451] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"448.566346ms","start":"2026-08-13T08:35:51.322803Z","end":"2026-08-13T08:35:51.77137Z","steps":["trace[1827753451] 'process raft request' (duration: 389.247263ms)","trace[1827753451] 'compare' (duration: 58.789579ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:35:51.7717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:51.322774Z","time spent":"448.753121ms","remote":"127.0.0.1:43610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:35:53.090809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.819822ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:35:53.091024Z","caller":"traceutil/trace.go:171","msg":"trace[1799347617] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.257042621s","start":"2026-08-13T08:35:51.833968Z","end":"2026-08-13T08:35:53.09101Z","steps":["trace[1799347617] 'process raft request' (duration: 1.25701692s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:53.091066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:51.833881Z","time spent":"1.257167915s","remote":"127.0.0.1:43744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:35:53.091317Z","caller":"traceutil/trace.go:171","msg":"trace[660129007] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:656; }","duration":"1.517204487s","start":"2026-08-13T08:35:51.574073Z","end":"2026-08-13T08:35:53.091277Z","steps":["trace[660129007] 'read index received' (duration: 137.757873ms)","trace[660129007] 'applied index is now lower than readState.Index' (duration: 1.379442784s)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:35:53.091416Z","caller":"traceutil/trace.go:171","msg":"trace[2081662364] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.615032062s","start":"2026-08-13T08:35:51.476373Z","end":"2026-08-13T08:35:53.091405Z","steps":["trace[2081662364] 'process raft request' (duration: 1.004551153s)","trace[2081662364] 'compare' (duration: 609.681018ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:35:53.091464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:51.476337Z","time spent":"1.615103094s","remote":"127.0.0.1:43778","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-08-13T08:35:53.091508Z","caller":"traceutil/trace.go:171","msg":"trace[916519147] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.501964171s","start":"2026-08-13T08:35:51.589521Z","end":"2026-08-13T08:35:53.091485Z","steps":["trace[916519147] 'process raft request' (duration: 1.501377036s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:53.091625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:51.589485Z","time spent":"1.502061553s","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:35:53.091631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.142770869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:35:53.091654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.535329679s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-13T08:35:53.091679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.202707787s","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-08-13T08:35:53.091695Z","caller":"traceutil/trace.go:171","msg":"trace[411857233] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"1.535431321s","start":"2026-08-13T08:35:51.556252Z","end":"2026-08-13T08:35:53.091683Z","steps":["trace[411857233] 'agreement among raft nodes before linearized reading' (duration: 1.535299207s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:53.091718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:51.556218Z","time spent":"1.535494043s","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-13T08:35:53.091711Z","caller":"traceutil/trace.go:171","msg":"trace[2120574966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"1.142874182s","start":"2026-08-13T08:35:51.948806Z","end":"2026-08-13T08:35:53.09168Z","steps":["trace[2120574966] 'agreement among raft nodes before linearized reading' (duration: 1.142744238s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:53.091705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.206593039s","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-08-13T08:35:53.091726Z","caller":"traceutil/trace.go:171","msg":"trace[1193880002] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"1.202766649s","start":"2026-08-13T08:35:51.88894Z","end":"2026-08-13T08:35:53.091707Z","steps":["trace[1193880002] 'agreement among raft nodes before linearized reading' (duration: 1.202605715s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:53.091761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:51.88893Z","time spent":"1.202826281s","remote":"127.0.0.1:43778","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-08-13T08:35:53.091764Z","caller":"traceutil/trace.go:171","msg":"trace[1324598845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"1.206724193s","start":"2026-08-13T08:35:51.885027Z","end":"2026-08-13T08:35:53.091751Z","steps":["trace[1324598845] 'agreement among raft nodes before linearized reading' (duration: 1.206515997s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:35:53.09176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:51.948785Z","time spent":"1.142964184s","remote":"127.0.0.1:43500","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-08-13T08:35:53.091794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:35:51.884998Z","time spent":"1.206790595s","remote":"127.0.0.1:43778","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":"warn","ts":"2026-08-13T08:35:54.786257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.378248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:35:54.786405Z","caller":"traceutil/trace.go:171","msg":"trace[1624453834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"154.641934ms","start":"2026-08-13T08:35:54.631733Z","end":"2026-08-13T08:35:54.786375Z","steps":["trace[1624453834] 'range keys from in-memory index tree' (duration: 154.188203ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:36:08.381437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.358773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:36:08.381564Z","caller":"traceutil/trace.go:171","msg":"trace[1312457175] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"722.941335ms","start":"2026-08-13T08:36:07.658605Z","end":"2026-08-13T08:36:08.381547Z","steps":["trace[1312457175] 'read index received' (duration: 119.303096ms)","trace[1312457175] 'applied index is now lower than readState.Index' (duration: 603.636959ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:36:08.381665Z","caller":"traceutil/trace.go:171","msg":"trace[1229825418] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"809.441177ms","start":"2026-08-13T08:36:07.572159Z","end":"2026-08-13T08:36:08.3816Z","steps":["trace[1229825418] 'process raft request' (duration: 205.815197ms)","trace[1229825418] 'compare' (duration: 603.079196ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:36:08.381761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.172661ms","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-08-13T08:36:08.381794Z","caller":"traceutil/trace.go:171","msg":"trace[129367624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"723.252343ms","start":"2026-08-13T08:36:07.658532Z","end":"2026-08-13T08:36:08.381785Z","steps":["trace[129367624] 'agreement among raft nodes before linearized reading' (duration: 723.106249ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:36:08.381829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:36:07.658501Z","time spent":"723.320845ms","remote":"127.0.0.1:43778","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-08-13T08:36:08.381904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.832846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:36:08.382117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:36:07.572138Z","time spent":"809.663282ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:36:08.381971Z","caller":"traceutil/trace.go:171","msg":"trace[1905930564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"434.928469ms","start":"2026-08-13T08:36:07.947016Z","end":"2026-08-13T08:36:08.381945Z","steps":["trace[1905930564] 'agreement among raft nodes before linearized reading' (duration: 434.840636ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:36:08.382339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:36:07.946996Z","time spent":"435.328149ms","remote":"127.0.0.1:43500","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-08-13T08:36:37.810987Z","caller":"traceutil/trace.go:171","msg":"trace[1538635251] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"351.341513ms","start":"2026-08-13T08:36:37.459614Z","end":"2026-08-13T08:36:37.810955Z","steps":["trace[1538635251] 'process raft request' (duration: 351.167469ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:36:37.811173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:36:37.459585Z","time spent":"351.491838ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:36:37.815492Z","caller":"traceutil/trace.go:171","msg":"trace[1120905634] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"355.679867ms","start":"2026-08-13T08:36:37.459789Z","end":"2026-08-13T08:36:37.815469Z","steps":["trace[1120905634] 'process raft request' (duration: 355.354368ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:36:37.815593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:36:37.459774Z","time spent":"355.77226ms","remote":"127.0.0.1:43778","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-08-13T08:37:38.919621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.316828ms","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-08-13T08:37:38.919807Z","caller":"traceutil/trace.go:171","msg":"trace[609927781] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1920; }","duration":"368.566015ms","start":"2026-08-13T08:37:38.551219Z","end":"2026-08-13T08:37:38.919785Z","steps":["trace[609927781] 'range keys from in-memory index tree' (duration: 368.139633ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:37:38.919878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:37:38.551193Z","time spent":"368.675247ms","remote":"127.0.0.1:44620","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-08-13T08:37:39.193407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.360969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:37:39.193569Z","caller":"traceutil/trace.go:171","msg":"trace[1560515781] linearizableReadLoop","detail":"{readStateIndex:1998; appliedIndex:1996; }","duration":"238.350871ms","start":"2026-08-13T08:37:38.955206Z","end":"2026-08-13T08:37:39.193557Z","steps":["trace[1560515781] 'read index received' (duration: 97.486179ms)","trace[1560515781] 'applied index is now lower than readState.Index' (duration: 140.864052ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:37:39.193618Z","caller":"traceutil/trace.go:171","msg":"trace[32075229] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"259.702ms","start":"2026-08-13T08:37:38.933893Z","end":"2026-08-13T08:37:39.193595Z","steps":["trace[32075229] 'process raft request' (duration: 259.610868ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:37:39.193713Z","caller":"traceutil/trace.go:171","msg":"trace[1279649869] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"268.743416ms","start":"2026-08-13T08:37:38.924953Z","end":"2026-08-13T08:37:39.193697Z","steps":["trace[1279649869] 'process raft request' (duration: 127.802652ms)","trace[1279649869] 'compare' (duration: 139.976219ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:37:39.193865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.294558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:37:39.193844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.681246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c10e24dd-75d9-4b28-b058-51479ff42ff8\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-08-13T08:37:39.193894Z","caller":"traceutil/trace.go:171","msg":"trace[1755365444] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1923; }","duration":"246.564265ms","start":"2026-08-13T08:37:38.94732Z","end":"2026-08-13T08:37:39.193885Z","steps":["trace[1755365444] 'agreement among raft nodes before linearized reading' (duration: 246.308149ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:37:39.193927Z","caller":"traceutil/trace.go:171","msg":"trace[277013872] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c10e24dd-75d9-4b28-b058-51479ff42ff8; range_end:; response_count:1; response_revision:1923; }","duration":"195.85086ms","start":"2026-08-13T08:37:38.998056Z","end":"2026-08-13T08:37:39.193907Z","steps":["trace[277013872] 'agreement among raft nodes before linearized reading' (duration: 195.672575ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:37:39.456369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.081327ms","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-08-13T08:37:39.45656Z","caller":"traceutil/trace.go:171","msg":"trace[950112454] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1923; }","duration":"162.310573ms","start":"2026-08-13T08:37:39.294229Z","end":"2026-08-13T08:37:39.45654Z","steps":["trace[950112454] 'range keys from in-memory index tree' (duration: 162.066267ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:37:39.457313Z","caller":"traceutil/trace.go:171","msg":"trace[488495167] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"213.012828ms","start":"2026-08-13T08:37:39.244274Z","end":"2026-08-13T08:37:39.457287Z","steps":["trace[488495167] 'process raft request' (duration: 204.597458ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:37:52.478913Z","caller":"traceutil/trace.go:171","msg":"trace[1343045140] linearizableReadLoop","detail":"{readStateIndex:2115; appliedIndex:2114; }","duration":"165.498486ms","start":"2026-08-13T08:37:52.313392Z","end":"2026-08-13T08:37:52.478891Z","steps":["trace[1343045140] 'read index received' (duration: 165.321862ms)","trace[1343045140] 'applied index is now lower than readState.Index' (duration: 175.484µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:37:52.479305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.911707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11989"} {"level":"info","ts":"2026-08-13T08:37:52.479343Z","caller":"traceutil/trace.go:171","msg":"trace[737009573] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2038; }","duration":"166.00946ms","start":"2026-08-13T08:37:52.313324Z","end":"2026-08-13T08:37:52.479334Z","steps":["trace[737009573] 'agreement among raft nodes before linearized reading' (duration: 165.65365ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:37:52.479638Z","caller":"traceutil/trace.go:171","msg":"trace[991995524] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"203.513841ms","start":"2026-08-13T08:37:52.276114Z","end":"2026-08-13T08:37:52.479627Z","steps":["trace[991995524] 'process raft request' (duration: 202.642878ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:37:58.447518Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976534390800962714,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:37:58.587194Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.023428885s","expected-duration":"1s"} {"level":"info","ts":"2026-08-13T08:37:58.587566Z","caller":"traceutil/trace.go:171","msg":"trace[281576460] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"1.023879507s","start":"2026-08-13T08:37:57.56366Z","end":"2026-08-13T08:37:58.58754Z","steps":["trace[281576460] 'process raft request' (duration: 1.023725393s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:37:58.587704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:37:57.563644Z","time spent":"1.02397685s","remote":"127.0.0.1:43778","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-08-13T08:37:58.588285Z","caller":"traceutil/trace.go:171","msg":"trace[1882049217] transaction","detail":"{read_only:false; response_revision:2073; number_of_response:1; }","duration":"432.493437ms","start":"2026-08-13T08:37:58.155781Z","end":"2026-08-13T08:37:58.588274Z","steps":["trace[1882049217] 'process raft request' (duration: 432.429895ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:37:58.5884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:37:58.155755Z","time spent":"432.556417ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:37:58.588569Z","caller":"traceutil/trace.go:171","msg":"trace[1100167898] linearizableReadLoop","detail":"{readStateIndex:2151; appliedIndex:2149; }","duration":"641.237643ms","start":"2026-08-13T08:37:57.947302Z","end":"2026-08-13T08:37:58.588539Z","steps":["trace[1100167898] 'read index received' (duration: 640.125205ms)","trace[1100167898] 'applied index is now lower than readState.Index' (duration: 1.111488ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:37:58.588773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.472309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:37:58.588847Z","caller":"traceutil/trace.go:171","msg":"trace[913036116] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2075; }","duration":"641.571732ms","start":"2026-08-13T08:37:57.94726Z","end":"2026-08-13T08:37:58.588832Z","steps":["trace[913036116] 'agreement among raft nodes before linearized reading' (duration: 641.479459ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:37:58.588906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:37:57.947247Z","time spent":"641.646903ms","remote":"127.0.0.1:43500","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-08-13T08:37:58.588903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.683666ms","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-08-13T08:37:58.589036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.067383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-13T08:37:58.589451Z","caller":"traceutil/trace.go:171","msg":"trace[1753452871] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2075; }","duration":"365.507365ms","start":"2026-08-13T08:37:58.223922Z","end":"2026-08-13T08:37:58.589429Z","steps":["trace[1753452871] 'agreement among raft nodes before linearized reading' (duration: 365.041632ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:37:58.589052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.476405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-13T08:37:58.589582Z","caller":"traceutil/trace.go:171","msg":"trace[1374041249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2075; }","duration":"350.042291ms","start":"2026-08-13T08:37:58.239528Z","end":"2026-08-13T08:37:58.589571Z","steps":["trace[1374041249] 'agreement among raft nodes before linearized reading' (duration: 349.427814ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:37:58.589641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:37:58.239507Z","time spent":"350.124313ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T08:37:58.589123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.79752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T08:37:58.589789Z","caller":"traceutil/trace.go:171","msg":"trace[709267001] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:2075; }","duration":"198.495309ms","start":"2026-08-13T08:37:58.391276Z","end":"2026-08-13T08:37:58.589772Z","steps":["trace[709267001] 'agreement among raft nodes before linearized reading' (duration: 197.79846ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:37:58.589242Z","caller":"traceutil/trace.go:171","msg":"trace[956561102] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2075; }","duration":"634.064256ms","start":"2026-08-13T08:37:57.955169Z","end":"2026-08-13T08:37:58.589234Z","steps":["trace[956561102] 'agreement among raft nodes before linearized reading' (duration: 633.592613ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:37:58.589136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.945843ms","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":"warn","ts":"2026-08-13T08:37:58.589994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:37:57.955159Z","time spent":"634.796976ms","remote":"127.0.0.1:43778","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-08-13T08:37:58.590001Z","caller":"traceutil/trace.go:171","msg":"trace[518552114] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2075; }","duration":"530.837278ms","start":"2026-08-13T08:37:58.059154Z","end":"2026-08-13T08:37:58.589991Z","steps":["trace[518552114] 'agreement among raft nodes before linearized reading' (duration: 529.905213ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:37:58.59033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:37:58.059135Z","time spent":"531.183677ms","remote":"127.0.0.1:44620","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-08-13T08:37:58.589523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:37:58.223901Z","time spent":"365.603258ms","remote":"127.0.0.1:43778","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-08-13T08:38:09.784567Z","caller":"traceutil/trace.go:171","msg":"trace[585913808] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"301.70306ms","start":"2026-08-13T08:38:09.482827Z","end":"2026-08-13T08:38:09.78453Z","steps":["trace[585913808] 'process raft request' (duration: 243.835966ms)","trace[585913808] 'compare' (duration: 57.72832ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:38:09.784757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:09.482798Z","time spent":"301.869813ms","remote":"127.0.0.1:43778","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-08-13T08:38:14.074576Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976534390800962912,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:38:14.17257Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.470671357s","expected-duration":"1s"} {"level":"info","ts":"2026-08-13T08:38:14.173108Z","caller":"traceutil/trace.go:171","msg":"trace[659532015] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"1.471318724s","start":"2026-08-13T08:38:12.701767Z","end":"2026-08-13T08:38:14.173086Z","steps":["trace[659532015] 'process raft request' (duration: 1.471153869s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.173263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:12.701737Z","time spent":"1.471438737s","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:38:14.206803Z","caller":"traceutil/trace.go:171","msg":"trace[1864259323] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"1.501880363s","start":"2026-08-13T08:38:12.704891Z","end":"2026-08-13T08:38:14.206772Z","steps":["trace[1864259323] 'process raft request' (duration: 1.501524214s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.206997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:12.704868Z","time spent":"1.502028568s","remote":"127.0.0.1:43778","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-08-13T08:38:14.207493Z","caller":"traceutil/trace.go:171","msg":"trace[1204134936] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"1.502111029s","start":"2026-08-13T08:38:12.705354Z","end":"2026-08-13T08:38:14.207465Z","steps":["trace[1204134936] 'process raft request' (duration: 1.501330128s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.207682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:12.705334Z","time spent":"1.502251482s","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:38:14.211446Z","caller":"traceutil/trace.go:171","msg":"trace[1969109276] linearizableReadLoop","detail":"{readStateIndex:2243; appliedIndex:2239; }","duration":"1.503319861s","start":"2026-08-13T08:38:12.708097Z","end":"2026-08-13T08:38:14.211417Z","steps":["trace[1969109276] 'read index received' (duration: 1.464741252s)","trace[1969109276] 'applied index is now lower than readState.Index' (duration: 38.577109ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:38:14.211528Z","caller":"traceutil/trace.go:171","msg":"trace[1805650908] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"136.089558ms","start":"2026-08-13T08:38:14.075413Z","end":"2026-08-13T08:38:14.211502Z","steps":["trace[1805650908] 'process raft request' (duration: 135.77941ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.21171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.950561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:38:14.211733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.503626409s","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-08-13T08:38:14.211808Z","caller":"traceutil/trace.go:171","msg":"trace[2058351422] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2162; }","duration":"1.503738801s","start":"2026-08-13T08:38:12.708042Z","end":"2026-08-13T08:38:14.211781Z","steps":["trace[2058351422] 'agreement among raft nodes before linearized reading' (duration: 1.503502755s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.211843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.526169ms","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-08-13T08:38:14.211755Z","caller":"traceutil/trace.go:171","msg":"trace[1604185219] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:2162; }","duration":"137.036833ms","start":"2026-08-13T08:38:14.074705Z","end":"2026-08-13T08:38:14.211742Z","steps":["trace[1604185219] 'agreement among raft nodes before linearized reading' (duration: 136.954621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.211861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.25706789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18cb5096db21fd3c\" ","response":"range_response_count:1 size:846"} {"level":"warn","ts":"2026-08-13T08:38:14.211915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.401247971s","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":"warn","ts":"2026-08-13T08:38:14.21192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.257629526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:38:14.211983Z","caller":"traceutil/trace.go:171","msg":"trace[846362848] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2162; }","duration":"1.401326563s","start":"2026-08-13T08:38:12.81064Z","end":"2026-08-13T08:38:14.211967Z","steps":["trace[846362848] 'agreement among raft nodes before linearized reading' (duration: 1.40119786s)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:14.212002Z","caller":"traceutil/trace.go:171","msg":"trace[1967138492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2162; }","duration":"1.257735919s","start":"2026-08-13T08:38:12.954244Z","end":"2026-08-13T08:38:14.21198Z","steps":["trace[1967138492] 'agreement among raft nodes before linearized reading' (duration: 1.257651766s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.212011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.491408969s","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-08-13T08:38:14.212018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:12.810629Z","time spent":"1.401379204s","remote":"127.0.0.1:44620","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-08-13T08:38:14.212046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:12.954221Z","time spent":"1.257818061s","remote":"127.0.0.1:43500","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-08-13T08:38:14.212059Z","caller":"traceutil/trace.go:171","msg":"trace[792533698] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2162; }","duration":"1.49147253s","start":"2026-08-13T08:38:12.720573Z","end":"2026-08-13T08:38:14.212046Z","steps":["trace[792533698] 'agreement among raft nodes before linearized reading' (duration: 1.491334977s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.211806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.497158809s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-13T08:38:14.212101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:12.720565Z","time spent":"1.491524951s","remote":"127.0.0.1:43778","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":"info","ts":"2026-08-13T08:38:14.212122Z","caller":"traceutil/trace.go:171","msg":"trace[638016284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2162; }","duration":"1.497528049s","start":"2026-08-13T08:38:12.714578Z","end":"2026-08-13T08:38:14.212106Z","steps":["trace[638016284] 'agreement among raft nodes before linearized reading' (duration: 1.497044626s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.212208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:12.714561Z","time spent":"1.497632811s","remote":"127.0.0.1:43778","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":"warn","ts":"2026-08-13T08:38:14.212194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.242099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:38:14.211857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.258210261s","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-08-13T08:38:14.21231Z","caller":"traceutil/trace.go:171","msg":"trace[292372608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2162; }","duration":"1.258693004s","start":"2026-08-13T08:38:12.953598Z","end":"2026-08-13T08:38:14.212291Z","steps":["trace[292372608] 'agreement among raft nodes before linearized reading' (duration: 1.258072088s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.212357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:12.95358Z","time spent":"1.258764025s","remote":"127.0.0.1:43778","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-08-13T08:38:14.211867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:12.708005Z","time spent":"1.503850124s","remote":"127.0.0.1:43778","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-08-13T08:38:14.211871Z","caller":"traceutil/trace.go:171","msg":"trace[625037297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2162; }","duration":"136.603081ms","start":"2026-08-13T08:38:14.075261Z","end":"2026-08-13T08:38:14.211864Z","steps":["trace[625037297] 'agreement among raft nodes before linearized reading' (duration: 136.518108ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:14.212305Z","caller":"traceutil/trace.go:171","msg":"trace[296318493] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2162; }","duration":"137.381012ms","start":"2026-08-13T08:38:14.074895Z","end":"2026-08-13T08:38:14.212276Z","steps":["trace[296318493] 'agreement among raft nodes before linearized reading' (duration: 137.100475ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:14.211938Z","caller":"traceutil/trace.go:171","msg":"trace[1960331606] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18cb5096db21fd3c; range_end:; response_count:1; response_revision:2162; }","duration":"1.257177903s","start":"2026-08-13T08:38:12.954743Z","end":"2026-08-13T08:38:14.211921Z","steps":["trace[1960331606] 'agreement among raft nodes before linearized reading' (duration: 1.256973718s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:14.212577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:12.954716Z","time spent":"1.257839551s","remote":"127.0.0.1:43588","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.18cb5096db21fd3c\" "} {"level":"info","ts":"2026-08-13T08:38:24.489517Z","caller":"traceutil/trace.go:171","msg":"trace[11188333] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"248.326904ms","start":"2026-08-13T08:38:24.241166Z","end":"2026-08-13T08:38:24.489492Z","steps":["trace[11188333] 'process raft request' (duration: 248.207421ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:24.489656Z","caller":"traceutil/trace.go:171","msg":"trace[505594521] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"248.426257ms","start":"2026-08-13T08:38:24.241186Z","end":"2026-08-13T08:38:24.489612Z","steps":["trace[505594521] 'process raft request' (duration: 248.248242ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:24.489572Z","caller":"traceutil/trace.go:171","msg":"trace[1124932362] linearizableReadLoop","detail":"{readStateIndex:2302; appliedIndex:2298; }","duration":"208.206444ms","start":"2026-08-13T08:38:24.281333Z","end":"2026-08-13T08:38:24.48954Z","steps":["trace[1124932362] 'read index received' (duration: 951.544µs)","trace[1124932362] 'applied index is now lower than readState.Index' (duration: 207.25326ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:38:24.489592Z","caller":"traceutil/trace.go:171","msg":"trace[2137157507] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"250.007977ms","start":"2026-08-13T08:38:24.239532Z","end":"2026-08-13T08:38:24.48954Z","steps":["trace[2137157507] 'process raft request' (duration: 249.658078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:24.489873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.528753ms","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-08-13T08:38:24.489938Z","caller":"traceutil/trace.go:171","msg":"trace[2139296492] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2217; }","duration":"208.638325ms","start":"2026-08-13T08:38:24.281284Z","end":"2026-08-13T08:38:24.489922Z","steps":["trace[2139296492] 'agreement among raft nodes before linearized reading' (duration: 208.397049ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:24.490069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.004467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-13T08:38:24.490139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.801704ms","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-08-13T08:38:24.490201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.13586ms","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-08-13T08:38:24.490201Z","caller":"traceutil/trace.go:171","msg":"trace[737298372] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2217; }","duration":"199.99115ms","start":"2026-08-13T08:38:24.290195Z","end":"2026-08-13T08:38:24.490186Z","steps":["trace[737298372] 'agreement among raft nodes before linearized reading' (duration: 199.680862ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:24.490303Z","caller":"traceutil/trace.go:171","msg":"trace[1689947321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2217; }","duration":"193.270234ms","start":"2026-08-13T08:38:24.297015Z","end":"2026-08-13T08:38:24.490285Z","steps":["trace[1689947321] 'agreement among raft nodes before linearized reading' (duration: 193.12369ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:24.490134Z","caller":"traceutil/trace.go:171","msg":"trace[331973398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2217; }","duration":"193.092079ms","start":"2026-08-13T08:38:24.297026Z","end":"2026-08-13T08:38:24.490118Z","steps":["trace[331973398] 'agreement among raft nodes before linearized reading' (duration: 192.907584ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:24.490069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.430888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-13T08:38:24.490084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.177361ms","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-08-13T08:38:24.490546Z","caller":"traceutil/trace.go:171","msg":"trace[2027738377] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2217; }","duration":"198.685724ms","start":"2026-08-13T08:38:24.291847Z","end":"2026-08-13T08:38:24.490533Z","steps":["trace[2027738377] 'agreement among raft nodes before linearized reading' (duration: 198.10892ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:24.490421Z","caller":"traceutil/trace.go:171","msg":"trace[1298334578] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2217; }","duration":"193.817078ms","start":"2026-08-13T08:38:24.296593Z","end":"2026-08-13T08:38:24.49041Z","steps":["trace[1298334578] 'agreement among raft nodes before linearized reading' (duration: 193.345526ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:24.748096Z","caller":"traceutil/trace.go:171","msg":"trace[1971102791] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"252.983215ms","start":"2026-08-13T08:38:24.495086Z","end":"2026-08-13T08:38:24.74807Z","steps":["trace[1971102791] 'process raft request' (duration: 153.021162ms)","trace[1971102791] 'compare' (duration: 99.768778ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:38:24.748474Z","caller":"traceutil/trace.go:171","msg":"trace[712855466] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"253.313453ms","start":"2026-08-13T08:38:24.495113Z","end":"2026-08-13T08:38:24.748427Z","steps":["trace[712855466] 'process raft request' (duration: 252.907343ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:24.748853Z","caller":"traceutil/trace.go:171","msg":"trace[36578995] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"253.15433ms","start":"2026-08-13T08:38:24.495378Z","end":"2026-08-13T08:38:24.748532Z","steps":["trace[36578995] 'process raft request' (duration: 252.825911ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:24.748928Z","caller":"traceutil/trace.go:171","msg":"trace[924826905] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"253.211102ms","start":"2026-08-13T08:38:24.495701Z","end":"2026-08-13T08:38:24.748912Z","steps":["trace[924826905] 'process raft request' (duration: 252.782161ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:24.748929Z","caller":"traceutil/trace.go:171","msg":"trace[666423307] linearizableReadLoop","detail":"{readStateIndex:2307; appliedIndex:2303; }","duration":"116.988529ms","start":"2026-08-13T08:38:24.631911Z","end":"2026-08-13T08:38:24.748899Z","steps":["trace[666423307] 'read index received' (duration: 16.105652ms)","trace[666423307] 'applied index is now lower than readState.Index' (duration: 100.880517ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:38:24.749156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.235946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:38:24.74922Z","caller":"traceutil/trace.go:171","msg":"trace[1804177912] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2222; }","duration":"117.348569ms","start":"2026-08-13T08:38:24.631852Z","end":"2026-08-13T08:38:24.749201Z","steps":["trace[1804177912] 'agreement among raft nodes before linearized reading' (duration: 117.234376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:30.886918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.839573ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:38:30.887086Z","caller":"traceutil/trace.go:171","msg":"trace[837039333] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"540.265627ms","start":"2026-08-13T08:38:30.346801Z","end":"2026-08-13T08:38:30.887067Z","steps":["trace[837039333] 'process raft request' (duration: 412.199158ms)","trace[837039333] 'compare' (duration: 127.408382ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:38:30.887143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:30.346771Z","time spent":"540.34854ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:38:30.887313Z","caller":"traceutil/trace.go:171","msg":"trace[2000399869] transaction","detail":"{read_only:false; response_revision:2247; number_of_response:1; }","duration":"376.837884ms","start":"2026-08-13T08:38:30.510452Z","end":"2026-08-13T08:38:30.88729Z","steps":["trace[2000399869] 'process raft request' (duration: 376.562807ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:30.88746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:30.510425Z","time spent":"376.963658ms","remote":"127.0.0.1:43778","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-08-13T08:38:30.887503Z","caller":"traceutil/trace.go:171","msg":"trace[1667009830] linearizableReadLoop","detail":"{readStateIndex:2335; appliedIndex:2331; }","duration":"370.323243ms","start":"2026-08-13T08:38:30.517161Z","end":"2026-08-13T08:38:30.887484Z","steps":["trace[1667009830] 'read index received' (duration: 241.802903ms)","trace[1667009830] 'applied index is now lower than readState.Index' (duration: 128.51913ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:38:30.887825Z","caller":"traceutil/trace.go:171","msg":"trace[1593196267] transaction","detail":"{read_only:false; response_revision:2248; number_of_response:1; }","duration":"374.549855ms","start":"2026-08-13T08:38:30.513266Z","end":"2026-08-13T08:38:30.887815Z","steps":["trace[1593196267] 'process raft request' (duration: 373.944349ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:30.887831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.646722ms","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-08-13T08:38:30.887914Z","caller":"traceutil/trace.go:171","msg":"trace[1577963893] transaction","detail":"{read_only:false; response_revision:2249; number_of_response:1; }","duration":"373.595039ms","start":"2026-08-13T08:38:30.51431Z","end":"2026-08-13T08:38:30.887905Z","steps":["trace[1577963893] 'process raft request' (duration: 373.106916ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:30.887914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.348873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-13T08:38:30.887956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:30.514295Z","time spent":"373.64174ms","remote":"127.0.0.1:43778","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-08-13T08:38:30.887957Z","caller":"traceutil/trace.go:171","msg":"trace[1604643520] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2249; }","duration":"108.405865ms","start":"2026-08-13T08:38:30.779539Z","end":"2026-08-13T08:38:30.887945Z","steps":["trace[1604643520] 'agreement among raft nodes before linearized reading' (duration: 108.321123ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:30.887964Z","caller":"traceutil/trace.go:171","msg":"trace[1616429583] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2249; }","duration":"370.823587ms","start":"2026-08-13T08:38:30.517107Z","end":"2026-08-13T08:38:30.88793Z","steps":["trace[1616429583] 'agreement among raft nodes before linearized reading' (duration: 370.521399ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:30.888032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.519688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-13T08:38:30.888037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:30.517085Z","time spent":"370.935499ms","remote":"127.0.0.1:43778","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-08-13T08:38:30.888063Z","caller":"traceutil/trace.go:171","msg":"trace[320293158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2249; }","duration":"113.635591ms","start":"2026-08-13T08:38:30.774421Z","end":"2026-08-13T08:38:30.888056Z","steps":["trace[320293158] 'agreement among raft nodes before linearized reading' (duration: 113.531318ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:30.888082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.787832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:38:30.88812Z","caller":"traceutil/trace.go:171","msg":"trace[1216513256] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2249; }","duration":"137.866744ms","start":"2026-08-13T08:38:30.750243Z","end":"2026-08-13T08:38:30.88811Z","steps":["trace[1216513256] 'agreement among raft nodes before linearized reading' (duration: 137.796612ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:30.887882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:30.513239Z","time spent":"374.614076ms","remote":"127.0.0.1:43778","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-08-13T08:38:30.887828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.860347ms","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-08-13T08:38:30.888264Z","caller":"traceutil/trace.go:171","msg":"trace[1805024319] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2249; }","duration":"361.321348ms","start":"2026-08-13T08:38:30.526932Z","end":"2026-08-13T08:38:30.888253Z","steps":["trace[1805024319] 'agreement among raft nodes before linearized reading' (duration: 360.763854ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:30.888289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:30.526923Z","time spent":"361.35972ms","remote":"127.0.0.1:44620","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-08-13T08:38:30.888317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.682643ms","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-08-13T08:38:30.888447Z","caller":"traceutil/trace.go:171","msg":"trace[103688667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2249; }","duration":"113.908318ms","start":"2026-08-13T08:38:30.774518Z","end":"2026-08-13T08:38:30.888426Z","steps":["trace[103688667] 'agreement among raft nodes before linearized reading' (duration: 113.421796ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:30.888356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.916813ms","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-08-13T08:38:30.88859Z","caller":"traceutil/trace.go:171","msg":"trace[67110998] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2249; }","duration":"110.207291ms","start":"2026-08-13T08:38:30.778371Z","end":"2026-08-13T08:38:30.888579Z","steps":["trace[67110998] 'agreement among raft nodes before linearized reading' (duration: 109.744869ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:31.186993Z","caller":"traceutil/trace.go:171","msg":"trace[638378081] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"294.668145ms","start":"2026-08-13T08:38:30.892287Z","end":"2026-08-13T08:38:31.186956Z","steps":["trace[638378081] 'process raft request' (duration: 257.514474ms)","trace[638378081] 'compare' (duration: 36.881114ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:38:31.187216Z","caller":"traceutil/trace.go:171","msg":"trace[1858531928] linearizableReadLoop","detail":"{readStateIndex:2340; appliedIndex:2335; }","duration":"237.928241ms","start":"2026-08-13T08:38:30.949266Z","end":"2026-08-13T08:38:31.187195Z","steps":["trace[1858531928] 'read index received' (duration: 35.778146ms)","trace[1858531928] 'applied index is now lower than readState.Index' (duration: 202.149145ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:38:31.187262Z","caller":"traceutil/trace.go:171","msg":"trace[1593538503] transaction","detail":"{read_only:false; response_revision:2253; number_of_response:1; }","duration":"294.234404ms","start":"2026-08-13T08:38:30.892991Z","end":"2026-08-13T08:38:31.187225Z","steps":["trace[1593538503] 'process raft request' (duration: 293.900996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:31.187352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.077986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:38:31.187319Z","caller":"traceutil/trace.go:171","msg":"trace[1841807659] transaction","detail":"{read_only:false; response_revision:2254; number_of_response:1; }","duration":"294.163922ms","start":"2026-08-13T08:38:30.893127Z","end":"2026-08-13T08:38:31.187291Z","steps":["trace[1841807659] 'process raft request' (duration: 293.968947ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:31.187387Z","caller":"traceutil/trace.go:171","msg":"trace[304288510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2254; }","duration":"238.164888ms","start":"2026-08-13T08:38:30.949214Z","end":"2026-08-13T08:38:31.187379Z","steps":["trace[304288510] 'agreement among raft nodes before linearized reading' (duration: 238.082956ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:31.242595Z","caller":"traceutil/trace.go:171","msg":"trace[1452269874] transaction","detail":"{read_only:false; response_revision:2255; number_of_response:1; }","duration":"152.93758ms","start":"2026-08-13T08:38:31.089601Z","end":"2026-08-13T08:38:31.242538Z","steps":["trace[1452269874] 'process raft request' (duration: 152.711114ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:32.298855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.126497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:38:32.298957Z","caller":"traceutil/trace.go:171","msg":"trace[638780015] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2256; }","duration":"394.288971ms","start":"2026-08-13T08:38:31.904648Z","end":"2026-08-13T08:38:32.298937Z","steps":["trace[638780015] 'count revisions from in-memory index tree' (duration: 393.997883ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:32.299012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:31.904618Z","time spent":"394.377872ms","remote":"127.0.0.1:43804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:38:32.299168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.659405ms","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-08-13T08:38:32.299284Z","caller":"traceutil/trace.go:171","msg":"trace[1445203895] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2256; }","duration":"403.83965ms","start":"2026-08-13T08:38:31.895417Z","end":"2026-08-13T08:38:32.299256Z","steps":["trace[1445203895] 'range keys from in-memory index tree' (duration: 403.423739ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:32.299338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:31.895392Z","time spent":"403.934943ms","remote":"127.0.0.1:44620","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-08-13T08:38:32.705376Z","caller":"traceutil/trace.go:171","msg":"trace[1642589356] transaction","detail":"{read_only:false; response_revision:2257; number_of_response:1; }","duration":"394.914027ms","start":"2026-08-13T08:38:32.310388Z","end":"2026-08-13T08:38:32.705302Z","steps":["trace[1642589356] 'process raft request' (duration: 394.401434ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:32.705613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.310366Z","time spent":"395.124872ms","remote":"127.0.0.1:43778","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-08-13T08:38:33.67678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.743024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:38:33.67696Z","caller":"traceutil/trace.go:171","msg":"trace[1571277043] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"1.29526138s","start":"2026-08-13T08:38:32.381665Z","end":"2026-08-13T08:38:33.676926Z","steps":["trace[1571277043] 'process raft request' (duration: 490.27265ms)","trace[1571277043] 'compare' (duration: 804.267621ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:38:33.677022Z","caller":"traceutil/trace.go:171","msg":"trace[160724135] transaction","detail":"{read_only:false; response_revision:2259; number_of_response:1; }","duration":"784.287298ms","start":"2026-08-13T08:38:32.892717Z","end":"2026-08-13T08:38:33.677004Z","steps":["trace[160724135] 'process raft request' (duration: 784.197246ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:33.677021Z","caller":"traceutil/trace.go:171","msg":"trace[2062812195] linearizableReadLoop","detail":"{readStateIndex:2344; appliedIndex:2342; }","duration":"1.007560257s","start":"2026-08-13T08:38:32.66943Z","end":"2026-08-13T08:38:33.676991Z","steps":["trace[2062812195] 'read index received' (duration: 35.472938ms)","trace[2062812195] 'applied index is now lower than readState.Index' (duration: 972.084879ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:38:33.67709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.381635Z","time spent":"1.295391984s","remote":"127.0.0.1:43778","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-08-13T08:38:33.677124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.892685Z","time spent":"784.388171ms","remote":"127.0.0.1:43778","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-08-13T08:38:33.678185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008749698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:38:33.678354Z","caller":"traceutil/trace.go:171","msg":"trace[26563843] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2259; }","duration":"1.008963953s","start":"2026-08-13T08:38:32.669366Z","end":"2026-08-13T08:38:33.67833Z","steps":["trace[26563843] 'agreement among raft nodes before linearized reading' (duration: 1.008577003s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:33.678638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.669341Z","time spent":"1.009280922s","remote":"127.0.0.1:48120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:38:34.37897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.78845ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:38:34.379316Z","caller":"traceutil/trace.go:171","msg":"trace[32248776] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"1.486085059s","start":"2026-08-13T08:38:32.893159Z","end":"2026-08-13T08:38:34.379244Z","steps":["trace[32248776] 'process raft request' (duration: 975.93514ms)","trace[32248776] 'compare' (duration: 509.308048ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:38:34.379561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.893149Z","time spent":"1.486253004s","remote":"127.0.0.1:43778","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-08-13T08:38:34.379608Z","caller":"traceutil/trace.go:171","msg":"trace[409366005] transaction","detail":"{read_only:false; response_revision:2261; number_of_response:1; }","duration":"1.485963337s","start":"2026-08-13T08:38:32.893607Z","end":"2026-08-13T08:38:34.37957Z","steps":["trace[409366005] 'process raft request' (duration: 1.485475854s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:34.379763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.89358Z","time spent":"1.486107291s","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:38:34.386393Z","caller":"traceutil/trace.go:171","msg":"trace[859583602] linearizableReadLoop","detail":"{readStateIndex:2348; appliedIndex:2345; }","duration":"709.263366ms","start":"2026-08-13T08:38:33.677109Z","end":"2026-08-13T08:38:34.386373Z","steps":["trace[859583602] 'read index received' (duration: 191.99503ms)","trace[859583602] 'applied index is now lower than readState.Index' (duration: 517.266626ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:38:34.386573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.194752692s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-13T08:38:34.386596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.673371087s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18cb5096db21fd3c\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-08-13T08:38:34.38663Z","caller":"traceutil/trace.go:171","msg":"trace[179436370] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2261; }","duration":"1.194845555s","start":"2026-08-13T08:38:33.191771Z","end":"2026-08-13T08:38:34.386617Z","steps":["trace[179436370] 'agreement among raft nodes before linearized reading' (duration: 1.194640019s)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:34.386647Z","caller":"traceutil/trace.go:171","msg":"trace[940188185] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18cb5096db21fd3c; range_end:; response_count:1; response_revision:2261; }","duration":"1.673461809s","start":"2026-08-13T08:38:32.713161Z","end":"2026-08-13T08:38:34.386622Z","steps":["trace[940188185] 'agreement among raft nodes before linearized reading' (duration: 1.673285854s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:34.386635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080052903s","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":"warn","ts":"2026-08-13T08:38:34.386689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.713125Z","time spent":"1.673555611s","remote":"127.0.0.1:43588","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.18cb5096db21fd3c\" "} {"level":"warn","ts":"2026-08-13T08:38:34.386708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143132742s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:38:34.386703Z","caller":"traceutil/trace.go:171","msg":"trace[138739531] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2261; }","duration":"1.080186797s","start":"2026-08-13T08:38:33.306502Z","end":"2026-08-13T08:38:34.386689Z","steps":["trace[138739531] 'agreement among raft nodes before linearized reading' (duration: 1.079986001s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:34.38673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.3973628s","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-08-13T08:38:34.386751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.194654029s","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-08-13T08:38:34.386753Z","caller":"traceutil/trace.go:171","msg":"trace[1753305195] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2261; }","duration":"1.143215954s","start":"2026-08-13T08:38:33.243521Z","end":"2026-08-13T08:38:34.386737Z","steps":["trace[1753305195] 'agreement among raft nodes before linearized reading' (duration: 1.143160952s)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:38:34.386795Z","caller":"traceutil/trace.go:171","msg":"trace[1895347007] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2261; }","duration":"1.19471259s","start":"2026-08-13T08:38:33.192074Z","end":"2026-08-13T08:38:34.386787Z","steps":["trace[1895347007] 'agreement among raft nodes before linearized reading' (duration: 1.194609987s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:34.386806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:33.243497Z","time spent":"1.143299656s","remote":"127.0.0.1:42620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:38:34.386832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:33.192066Z","time spent":"1.194757671s","remote":"127.0.0.1:43778","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-08-13T08:38:34.386663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:33.191751Z","time spent":"1.194904386s","remote":"127.0.0.1:43778","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-08-13T08:38:34.386796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:33.306457Z","time spent":"1.080298189s","remote":"127.0.0.1:44620","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-08-13T08:38:34.386858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.39660033s","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-08-13T08:38:34.386929Z","caller":"traceutil/trace.go:171","msg":"trace[1314357653] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2261; }","duration":"1.397557025s","start":"2026-08-13T08:38:32.989309Z","end":"2026-08-13T08:38:34.386866Z","steps":["trace[1314357653] 'agreement among raft nodes before linearized reading' (duration: 1.397119404s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:34.386636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.194859205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-13T08:38:34.386966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.989281Z","time spent":"1.397677228s","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T08:38:34.386847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.438009922s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:38:34.387109Z","caller":"traceutil/trace.go:171","msg":"trace[593409409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2261; }","duration":"1.396712502s","start":"2026-08-13T08:38:32.990196Z","end":"2026-08-13T08:38:34.386908Z","steps":["trace[593409409] 'agreement among raft nodes before linearized reading' (duration: 1.396518537s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:34.387226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.990167Z","time spent":"1.39701671s","remote":"127.0.0.1:43778","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":"info","ts":"2026-08-13T08:38:34.387275Z","caller":"traceutil/trace.go:171","msg":"trace[203616174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2261; }","duration":"1.195247545s","start":"2026-08-13T08:38:33.191735Z","end":"2026-08-13T08:38:34.386982Z","steps":["trace[203616174] 'agreement among raft nodes before linearized reading' (duration: 1.194802414s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:34.387356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:33.191714Z","time spent":"1.195622324s","remote":"127.0.0.1:43778","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-08-13T08:38:34.387514Z","caller":"traceutil/trace.go:171","msg":"trace[1666820867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2261; }","duration":"1.438310661s","start":"2026-08-13T08:38:32.948764Z","end":"2026-08-13T08:38:34.387075Z","steps":["trace[1666820867] 'agreement among raft nodes before linearized reading' (duration: 1.437952421s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:34.387637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.615898574s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"info","ts":"2026-08-13T08:38:34.387706Z","caller":"traceutil/trace.go:171","msg":"trace[1404611720] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2261; }","duration":"1.616005186s","start":"2026-08-13T08:38:32.77168Z","end":"2026-08-13T08:38:34.387685Z","steps":["trace[1404611720] 'agreement among raft nodes before linearized reading' (duration: 1.615107053s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:38:34.387756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.771657Z","time spent":"1.616088269s","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12410,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-13T08:38:34.387801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:38:32.94874Z","time spent":"1.438832873s","remote":"127.0.0.1:43500","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-08-13T08:39:53.002929Z","caller":"traceutil/trace.go:171","msg":"trace[2033517398] transaction","detail":"{read_only:false; response_revision:2845; number_of_response:1; }","duration":"280.791858ms","start":"2026-08-13T08:39:52.72211Z","end":"2026-08-13T08:39:53.002901Z","steps":["trace[2033517398] 'process raft request' (duration: 280.614994ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:39:53.009721Z","caller":"traceutil/trace.go:171","msg":"trace[306812027] linearizableReadLoop","detail":"{readStateIndex:2956; appliedIndex:2954; }","duration":"148.604659ms","start":"2026-08-13T08:39:52.861105Z","end":"2026-08-13T08:39:53.009709Z","steps":["trace[306812027] 'read index received' (duration: 141.582805ms)","trace[306812027] 'applied index is now lower than readState.Index' (duration: 7.021084ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:39:53.009785Z","caller":"traceutil/trace.go:171","msg":"trace[229665175] transaction","detail":"{read_only:false; response_revision:2846; number_of_response:1; }","duration":"262.715307ms","start":"2026-08-13T08:39:52.747053Z","end":"2026-08-13T08:39:53.009768Z","steps":["trace[229665175] 'process raft request' (duration: 262.590944ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:39:53.01003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.911096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-13T08:39:53.010057Z","caller":"traceutil/trace.go:171","msg":"trace[1967555314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2846; }","duration":"148.994698ms","start":"2026-08-13T08:39:52.861054Z","end":"2026-08-13T08:39:53.010049Z","steps":["trace[1967555314] 'agreement among raft nodes before linearized reading' (duration: 148.731412ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:40:27.261416Z","caller":"traceutil/trace.go:171","msg":"trace[7299703] transaction","detail":"{read_only:false; response_revision:3052; number_of_response:1; }","duration":"148.573832ms","start":"2026-08-13T08:40:27.112819Z","end":"2026-08-13T08:40:27.261393Z","steps":["trace[7299703] 'process raft request' (duration: 148.424307ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:40:27.264887Z","caller":"traceutil/trace.go:171","msg":"trace[1292631022] transaction","detail":"{read_only:false; response_revision:3053; number_of_response:1; }","duration":"138.363806ms","start":"2026-08-13T08:40:27.126505Z","end":"2026-08-13T08:40:27.264869Z","steps":["trace[1292631022] 'process raft request' (duration: 138.226962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:40:27.455657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.140068ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:40:27.45611Z","caller":"traceutil/trace.go:171","msg":"trace[1636137509] transaction","detail":"{read_only:false; response_revision:3055; number_of_response:1; }","duration":"186.346765ms","start":"2026-08-13T08:40:27.269737Z","end":"2026-08-13T08:40:27.456084Z","steps":["trace[1636137509] 'process raft request' (duration: 34.645172ms)","trace[1636137509] 'compare' (duration: 150.919503ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:40:27.45626Z","caller":"traceutil/trace.go:171","msg":"trace[1636187357] transaction","detail":"{read_only:false; response_revision:3057; number_of_response:1; }","duration":"184.298893ms","start":"2026-08-13T08:40:27.271872Z","end":"2026-08-13T08:40:27.456171Z","steps":["trace[1636187357] 'process raft request' (duration: 184.020006ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:40:27.456383Z","caller":"traceutil/trace.go:171","msg":"trace[2024773869] transaction","detail":"{read_only:false; response_revision:3058; number_of_response:1; }","duration":"182.596628ms","start":"2026-08-13T08:40:27.273767Z","end":"2026-08-13T08:40:27.456364Z","steps":["trace[2024773869] 'process raft request' (duration: 182.165887ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:40:27.456397Z","caller":"traceutil/trace.go:171","msg":"trace[1834176283] transaction","detail":"{read_only:false; response_revision:3056; number_of_response:1; }","duration":"185.40861ms","start":"2026-08-13T08:40:27.270938Z","end":"2026-08-13T08:40:27.456346Z","steps":["trace[1834176283] 'process raft request' (duration: 184.887197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:40:33.462863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.971518ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:40:33.463035Z","caller":"traceutil/trace.go:171","msg":"trace[1857206070] linearizableReadLoop","detail":"{readStateIndex:3206; appliedIndex:3204; }","duration":"157.424582ms","start":"2026-08-13T08:40:33.305545Z","end":"2026-08-13T08:40:33.462969Z","steps":["trace[1857206070] 'read index received' (duration: 5.123004ms)","trace[1857206070] 'applied index is now lower than readState.Index' (duration: 152.300358ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:40:33.463034Z","caller":"traceutil/trace.go:171","msg":"trace[254994671] transaction","detail":"{read_only:false; response_revision:3088; number_of_response:1; }","duration":"181.669414ms","start":"2026-08-13T08:40:33.281335Z","end":"2026-08-13T08:40:33.463004Z","steps":["trace[254994671] 'process raft request' (duration: 54.451309ms)","trace[254994671] 'compare' (duration: 126.751823ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:40:33.463291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.758031ms","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-08-13T08:40:33.463325Z","caller":"traceutil/trace.go:171","msg":"trace[597398961] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3088; }","duration":"157.836153ms","start":"2026-08-13T08:40:33.30548Z","end":"2026-08-13T08:40:33.463317Z","steps":["trace[597398961] 'agreement among raft nodes before linearized reading' (duration: 157.681679ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:40:33.666215Z","caller":"traceutil/trace.go:171","msg":"trace[520253738] transaction","detail":"{read_only:false; response_revision:3090; number_of_response:1; }","duration":"167.73033ms","start":"2026-08-13T08:40:33.498454Z","end":"2026-08-13T08:40:33.666184Z","steps":["trace[520253738] 'process raft request' (duration: 81.348569ms)","trace[520253738] 'compare' (duration: 86.167785ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:40:33.666701Z","caller":"traceutil/trace.go:171","msg":"trace[1013352564] transaction","detail":"{read_only:false; response_revision:3091; number_of_response:1; }","duration":"168.096059ms","start":"2026-08-13T08:40:33.498499Z","end":"2026-08-13T08:40:33.666595Z","steps":["trace[1013352564] 'process raft request' (duration: 167.628287ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:40:33.666861Z","caller":"traceutil/trace.go:171","msg":"trace[1349443527] transaction","detail":"{read_only:false; response_revision:3092; number_of_response:1; }","duration":"167.637768ms","start":"2026-08-13T08:40:33.49919Z","end":"2026-08-13T08:40:33.666828Z","steps":["trace[1349443527] 'process raft request' (duration: 167.251818ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:40:33.666909Z","caller":"traceutil/trace.go:171","msg":"trace[1028022876] transaction","detail":"{read_only:false; response_revision:3093; number_of_response:1; }","duration":"167.487874ms","start":"2026-08-13T08:40:33.499343Z","end":"2026-08-13T08:40:33.666831Z","steps":["trace[1028022876] 'process raft request' (duration: 167.403522ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:40:34.028371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.021199ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-08-13T08:43:04.795276Z","caller":"traceutil/trace.go:171","msg":"trace[568794882] transaction","detail":"{read_only:false; response_revision:4083; number_of_response:1; }","duration":"198.266256ms","start":"2026-08-13T08:43:04.596975Z","end":"2026-08-13T08:43:04.795241Z","steps":["trace[568794882] 'process raft request' (duration: 197.441984ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:43:04.794618Z","caller":"traceutil/trace.go:171","msg":"trace[976078068] transaction","detail":"{read_only:false; response_revision:4082; number_of_response:1; }","duration":"262.950678ms","start":"2026-08-13T08:43:04.531559Z","end":"2026-08-13T08:43:04.794509Z","steps":["trace[976078068] 'process raft request' (duration: 224.326463ms)","trace[976078068] 'compare' (duration: 38.358937ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:43:04.795329Z","caller":"traceutil/trace.go:171","msg":"trace[1869350310] linearizableReadLoop","detail":"{readStateIndex:4239; appliedIndex:4237; }","duration":"175.443492ms","start":"2026-08-13T08:43:04.619858Z","end":"2026-08-13T08:43:04.795302Z","steps":["trace[1869350310] 'read index received' (duration: 136.427998ms)","trace[1869350310] 'applied index is now lower than readState.Index' (duration: 39.012184ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:43:04.795591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.71684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:43:04.795683Z","caller":"traceutil/trace.go:171","msg":"trace[1018133568] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4085; }","duration":"175.883973ms","start":"2026-08-13T08:43:04.619778Z","end":"2026-08-13T08:43:04.795662Z","steps":["trace[1018133568] 'agreement among raft nodes before linearized reading' (duration: 175.733139ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:18.986103Z","caller":"traceutil/trace.go:171","msg":"trace[280343207] transaction","detail":"{read_only:false; response_revision:4585; number_of_response:1; }","duration":"119.920024ms","start":"2026-08-13T08:44:18.866151Z","end":"2026-08-13T08:44:18.986071Z","steps":["trace[280343207] 'process raft request' (duration: 119.585044ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:27.319457Z","caller":"traceutil/trace.go:171","msg":"trace[1512019623] linearizableReadLoop","detail":"{readStateIndex:5165; appliedIndex:5164; }","duration":"194.144686ms","start":"2026-08-13T08:44:27.12528Z","end":"2026-08-13T08:44:27.319425Z","steps":["trace[1512019623] 'read index received' (duration: 193.858149ms)","trace[1512019623] 'applied index is now lower than readState.Index' (duration: 285.087µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:27.319578Z","caller":"traceutil/trace.go:171","msg":"trace[1777985094] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"282.115687ms","start":"2026-08-13T08:44:27.037428Z","end":"2026-08-13T08:44:27.319543Z","steps":["trace[1777985094] 'process raft request' (duration: 281.740968ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:27.319722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.420903ms","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-08-13T08:44:27.31977Z","caller":"traceutil/trace.go:171","msg":"trace[1022907246] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4973; }","duration":"194.528306ms","start":"2026-08-13T08:44:27.125227Z","end":"2026-08-13T08:44:27.319755Z","steps":["trace[1022907246] 'agreement among raft nodes before linearized reading' (duration: 194.372002ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:27.320336Z","caller":"traceutil/trace.go:171","msg":"trace[853631219] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"167.661807ms","start":"2026-08-13T08:44:27.152622Z","end":"2026-08-13T08:44:27.320284Z","steps":["trace[853631219] 'process raft request' (duration: 167.538203ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:27.320435Z","caller":"traceutil/trace.go:171","msg":"trace[1963158963] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"165.528532ms","start":"2026-08-13T08:44:27.154888Z","end":"2026-08-13T08:44:27.320416Z","steps":["trace[1963158963] 'process raft request' (duration: 165.359277ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:31.210354Z","caller":"traceutil/trace.go:171","msg":"trace[2539126] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"132.454979ms","start":"2026-08-13T08:44:31.077874Z","end":"2026-08-13T08:44:31.210329Z","steps":["trace[2539126] 'process raft request' (duration: 132.247414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:33.527538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.914765ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:44:33.527782Z","caller":"traceutil/trace.go:171","msg":"trace[2050038624] transaction","detail":"{read_only:false; response_revision:5164; number_of_response:1; }","duration":"203.91665ms","start":"2026-08-13T08:44:33.323829Z","end":"2026-08-13T08:44:33.527745Z","steps":["trace[2050038624] 'process raft request' (duration: 71.700457ms)","trace[2050038624] 'compare' (duration: 131.772312ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:33.527996Z","caller":"traceutil/trace.go:171","msg":"trace[1986935227] linearizableReadLoop","detail":"{readStateIndex:5363; appliedIndex:5360; }","duration":"176.146057ms","start":"2026-08-13T08:44:33.35181Z","end":"2026-08-13T08:44:33.527956Z","steps":["trace[1986935227] 'read index received' (duration: 43.692127ms)","trace[1986935227] 'applied index is now lower than readState.Index' (duration: 132.45305ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:33.527993Z","caller":"traceutil/trace.go:171","msg":"trace[272718674] transaction","detail":"{read_only:false; response_revision:5165; number_of_response:1; }","duration":"187.263807ms","start":"2026-08-13T08:44:33.340699Z","end":"2026-08-13T08:44:33.527962Z","steps":["trace[272718674] 'process raft request' (duration: 186.953899ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:33.528169Z","caller":"traceutil/trace.go:171","msg":"trace[528478138] transaction","detail":"{read_only:false; response_revision:5166; number_of_response:1; }","duration":"181.016786ms","start":"2026-08-13T08:44:33.347126Z","end":"2026-08-13T08:44:33.528143Z","steps":["trace[528478138] 'process raft request' (duration: 180.629405ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:33.528443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.396543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-13T08:44:33.528448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.647421ms","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-08-13T08:44:33.528476Z","caller":"traceutil/trace.go:171","msg":"trace[757153255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5166; }","duration":"169.472045ms","start":"2026-08-13T08:44:33.358995Z","end":"2026-08-13T08:44:33.528468Z","steps":["trace[757153255] 'agreement among raft nodes before linearized reading' (duration: 169.356462ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:33.528417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.484425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-08-13T08:44:33.528529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.553056ms","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-08-13T08:44:33.528578Z","caller":"traceutil/trace.go:171","msg":"trace[413295666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5166; }","duration":"169.626048ms","start":"2026-08-13T08:44:33.358933Z","end":"2026-08-13T08:44:33.528559Z","steps":["trace[413295666] 'agreement among raft nodes before linearized reading' (duration: 169.532906ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:33.528597Z","caller":"traceutil/trace.go:171","msg":"trace[1476111648] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5166; }","duration":"169.736981ms","start":"2026-08-13T08:44:33.358817Z","end":"2026-08-13T08:44:33.528554Z","steps":["trace[1476111648] 'agreement among raft nodes before linearized reading' (duration: 169.395552ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:33.528491Z","caller":"traceutil/trace.go:171","msg":"trace[1412769032] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5166; }","duration":"176.759944ms","start":"2026-08-13T08:44:33.351716Z","end":"2026-08-13T08:44:33.528476Z","steps":["trace[1412769032] 'agreement among raft nodes before linearized reading' (duration: 176.431046ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:36.87116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.774924ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:44:36.871334Z","caller":"traceutil/trace.go:171","msg":"trace[299544327] linearizableReadLoop","detail":"{readStateIndex:5496; appliedIndex:5494; }","duration":"430.996666ms","start":"2026-08-13T08:44:36.440324Z","end":"2026-08-13T08:44:36.87132Z","steps":["trace[299544327] 'read index received' (duration: 135.038137ms)","trace[299544327] 'applied index is now lower than readState.Index' (duration: 295.957599ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:36.871395Z","caller":"traceutil/trace.go:171","msg":"trace[1117134227] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"446.431517ms","start":"2026-08-13T08:44:36.424956Z","end":"2026-08-13T08:44:36.871387Z","steps":["trace[1117134227] 'process raft request' (duration: 446.280833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:36.87145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:36.424911Z","time spent":"446.505129ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:44:36.871491Z","caller":"traceutil/trace.go:171","msg":"trace[227013707] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"499.772197ms","start":"2026-08-13T08:44:36.371702Z","end":"2026-08-13T08:44:36.871474Z","steps":["trace[227013707] 'process raft request' (duration: 203.634443ms)","trace[227013707] 'compare' (duration: 295.668992ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:44:36.871496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.17409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c075d74f-fcc3-4160-b713-cb41b0dfe6d9\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-08-13T08:44:36.871529Z","caller":"traceutil/trace.go:171","msg":"trace[950852694] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c075d74f-fcc3-4160-b713-cb41b0dfe6d9; range_end:; response_count:1; response_revision:5295; }","duration":"431.241782ms","start":"2026-08-13T08:44:36.440277Z","end":"2026-08-13T08:44:36.871519Z","steps":["trace[950852694] 'agreement among raft nodes before linearized reading' (duration: 431.123459ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:36.871538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:36.371672Z","time spent":"499.845849ms","remote":"127.0.0.1:43716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":879,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T08:44:36.87155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:36.440263Z","time spent":"431.280933ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3625,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c075d74f-fcc3-4160-b713-cb41b0dfe6d9\" "} {"level":"info","ts":"2026-08-13T08:44:37.098074Z","caller":"traceutil/trace.go:171","msg":"trace[1816624034] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"429.209889ms","start":"2026-08-13T08:44:36.668832Z","end":"2026-08-13T08:44:37.098042Z","steps":["trace[1816624034] 'process raft request' (duration: 385.253093ms)","trace[1816624034] 'compare' (duration: 43.691829ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:37.098045Z","caller":"traceutil/trace.go:171","msg":"trace[2000992232] linearizableReadLoop","detail":"{readStateIndex:5497; appliedIndex:5496; }","duration":"226.650364ms","start":"2026-08-13T08:44:36.871355Z","end":"2026-08-13T08:44:37.098006Z","steps":["trace[2000992232] 'read index received' (duration: 182.727429ms)","trace[2000992232] 'applied index is now lower than readState.Index' (duration: 43.915954ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:37.098107Z","caller":"traceutil/trace.go:171","msg":"trace[979406811] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"222.071044ms","start":"2026-08-13T08:44:36.87599Z","end":"2026-08-13T08:44:37.098061Z","steps":["trace[979406811] 'process raft request' (duration: 221.90984ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:37.09822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:36.668781Z","time spent":"429.361762ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:44:37.098303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.949433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-13T08:44:37.098316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.504161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bgt8w\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-08-13T08:44:37.098346Z","caller":"traceutil/trace.go:171","msg":"trace[345148817] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5297; }","duration":"244.043236ms","start":"2026-08-13T08:44:36.854289Z","end":"2026-08-13T08:44:37.098333Z","steps":["trace[345148817] 'agreement among raft nodes before linearized reading' (duration: 243.912153ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:37.098377Z","caller":"traceutil/trace.go:171","msg":"trace[181035704] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bgt8w; range_end:; response_count:1; response_revision:5297; }","duration":"233.610514ms","start":"2026-08-13T08:44:36.86475Z","end":"2026-08-13T08:44:37.09836Z","steps":["trace[181035704] 'agreement among raft nodes before linearized reading' (duration: 233.314616ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:37.395494Z","caller":"traceutil/trace.go:171","msg":"trace[873668676] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"117.822429ms","start":"2026-08-13T08:44:37.277636Z","end":"2026-08-13T08:44:37.395458Z","steps":["trace[873668676] 'process raft request' (duration: 49.799577ms)","trace[873668676] 'compare' (duration: 67.843497ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:37.659744Z","caller":"traceutil/trace.go:171","msg":"trace[2091399100] linearizableReadLoop","detail":"{readStateIndex:5509; appliedIndex:5508; }","duration":"248.252875ms","start":"2026-08-13T08:44:37.41147Z","end":"2026-08-13T08:44:37.659723Z","steps":["trace[2091399100] 'read index received' (duration: 200.636385ms)","trace[2091399100] 'applied index is now lower than readState.Index' (duration: 47.61275ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:37.659846Z","caller":"traceutil/trace.go:171","msg":"trace[1452576527] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"365.602161ms","start":"2026-08-13T08:44:37.294203Z","end":"2026-08-13T08:44:37.659805Z","steps":["trace[1452576527] 'process raft request' (duration: 317.884839ms)","trace[1452576527] 'compare' (duration: 47.499737ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:44:37.659932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.44518ms","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-08-13T08:44:37.659996Z","caller":"traceutil/trace.go:171","msg":"trace[1472124926] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:5308; }","duration":"248.578493ms","start":"2026-08-13T08:44:37.411404Z","end":"2026-08-13T08:44:37.659982Z","steps":["trace[1472124926] 'agreement among raft nodes before linearized reading' (duration: 248.409329ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:37.660004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:37.294176Z","time spent":"365.752846ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4888,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:44:37.660784Z","caller":"traceutil/trace.go:171","msg":"trace[588051060] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"120.358345ms","start":"2026-08-13T08:44:37.540393Z","end":"2026-08-13T08:44:37.660751Z","steps":["trace[588051060] 'process raft request' (duration: 120.002206ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:37.661297Z","caller":"traceutil/trace.go:171","msg":"trace[725567920] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"118.235349ms","start":"2026-08-13T08:44:37.543047Z","end":"2026-08-13T08:44:37.661282Z","steps":["trace[725567920] 'process raft request' (duration: 117.748267ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:37.661304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.263281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-13T08:44:37.66141Z","caller":"traceutil/trace.go:171","msg":"trace[1476057325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5310; }","duration":"110.434676ms","start":"2026-08-13T08:44:37.550956Z","end":"2026-08-13T08:44:37.661391Z","steps":["trace[1476057325] 'agreement among raft nodes before linearized reading' (duration: 110.19635ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:37.661771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.728373ms","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-08-13T08:44:37.661823Z","caller":"traceutil/trace.go:171","msg":"trace[1803093270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5310; }","duration":"110.854357ms","start":"2026-08-13T08:44:37.550956Z","end":"2026-08-13T08:44:37.661811Z","steps":["trace[1803093270] 'agreement among raft nodes before linearized reading' (duration: 110.697833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:37.661834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.641898ms","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-08-13T08:44:37.661857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.749571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:44:37.66188Z","caller":"traceutil/trace.go:171","msg":"trace[917320637] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5310; }","duration":"111.73744ms","start":"2026-08-13T08:44:37.55013Z","end":"2026-08-13T08:44:37.661868Z","steps":["trace[917320637] 'agreement among raft nodes before linearized reading' (duration: 111.557006ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:37.661896Z","caller":"traceutil/trace.go:171","msg":"trace[923834987] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5310; }","duration":"169.830103ms","start":"2026-08-13T08:44:37.492055Z","end":"2026-08-13T08:44:37.661885Z","steps":["trace[923834987] 'agreement among raft nodes before linearized reading' (duration: 169.743421ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:37.661922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.245548ms","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-08-13T08:44:37.661962Z","caller":"traceutil/trace.go:171","msg":"trace[1058404967] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5310; }","duration":"111.31422ms","start":"2026-08-13T08:44:37.550636Z","end":"2026-08-13T08:44:37.661951Z","steps":["trace[1058404967] 'agreement among raft nodes before linearized reading' (duration: 111.206447ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:37.662586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.784178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786900"} {"level":"info","ts":"2026-08-13T08:44:37.662642Z","caller":"traceutil/trace.go:171","msg":"trace[536606343] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5310; }","duration":"203.87946ms","start":"2026-08-13T08:44:37.458747Z","end":"2026-08-13T08:44:37.662626Z","steps":["trace[536606343] 'agreement among raft nodes before linearized reading' (duration: 202.107764ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:39.423679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.855472ms","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-08-13T08:44:39.423863Z","caller":"traceutil/trace.go:171","msg":"trace[2122270248] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5336; }","duration":"130.071588ms","start":"2026-08-13T08:44:39.293765Z","end":"2026-08-13T08:44:39.423836Z","steps":["trace[2122270248] 'range keys from in-memory index tree' (duration: 129.822811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:39.424132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.681266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786900"} {"level":"info","ts":"2026-08-13T08:44:39.424223Z","caller":"traceutil/trace.go:171","msg":"trace[1667786027] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5336; }","duration":"223.82287ms","start":"2026-08-13T08:44:39.200382Z","end":"2026-08-13T08:44:39.424204Z","steps":["trace[1667786027] 'range keys from in-memory index tree' (duration: 223.192343ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:39.424178Z","caller":"traceutil/trace.go:171","msg":"trace[1797766678] transaction","detail":"{read_only:false; response_revision:5337; number_of_response:1; }","duration":"222.834313ms","start":"2026-08-13T08:44:39.201307Z","end":"2026-08-13T08:44:39.424141Z","steps":["trace[1797766678] 'process raft request' (duration: 182.114013ms)","trace[1797766678] 'compare' (duration: 40.565126ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:44:39.685211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.302289ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:44:39.685352Z","caller":"traceutil/trace.go:171","msg":"trace[1402253571] transaction","detail":"{read_only:false; response_revision:5338; number_of_response:1; }","duration":"195.82711ms","start":"2026-08-13T08:44:39.489506Z","end":"2026-08-13T08:44:39.685333Z","steps":["trace[1402253571] 'process raft request' (duration: 41.313636ms)","trace[1402253571] 'compare' (duration: 154.117004ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:39.867714Z","caller":"traceutil/trace.go:171","msg":"trace[1959324068] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"200.194924ms","start":"2026-08-13T08:44:39.667497Z","end":"2026-08-13T08:44:39.867692Z","steps":["trace[1959324068] 'process raft request' (duration: 192.050372ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:39.867866Z","caller":"traceutil/trace.go:171","msg":"trace[14316861] linearizableReadLoop","detail":"{readStateIndex:5542; appliedIndex:5540; }","duration":"180.665376ms","start":"2026-08-13T08:44:39.687172Z","end":"2026-08-13T08:44:39.867837Z","steps":["trace[14316861] 'read index received' (duration: 172.35528ms)","trace[14316861] 'applied index is now lower than readState.Index' (duration: 8.307636ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:39.867949Z","caller":"traceutil/trace.go:171","msg":"trace[1944833989] transaction","detail":"{read_only:false; response_revision:5340; number_of_response:1; }","duration":"199.731433ms","start":"2026-08-13T08:44:39.668174Z","end":"2026-08-13T08:44:39.867905Z","steps":["trace[1944833989] 'process raft request' (duration: 199.476926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:39.868256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.045716ms","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-08-13T08:44:39.868261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.504022ms","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-08-13T08:44:39.868349Z","caller":"traceutil/trace.go:171","msg":"trace[744793091] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5340; }","duration":"181.20695ms","start":"2026-08-13T08:44:39.687122Z","end":"2026-08-13T08:44:39.868329Z","steps":["trace[744793091] 'agreement among raft nodes before linearized reading' (duration: 180.8316ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:39.868375Z","caller":"traceutil/trace.go:171","msg":"trace[143833753] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5340; }","duration":"180.671266ms","start":"2026-08-13T08:44:39.687677Z","end":"2026-08-13T08:44:39.868348Z","steps":["trace[143833753] 'agreement among raft nodes before linearized reading' (duration: 180.322537ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:39.86845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.969347ms","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-08-13T08:44:39.868565Z","caller":"traceutil/trace.go:171","msg":"trace[1933476136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5340; }","duration":"180.11485ms","start":"2026-08-13T08:44:39.688427Z","end":"2026-08-13T08:44:39.868542Z","steps":["trace[1933476136] 'agreement among raft nodes before linearized reading' (duration: 179.845953ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:39.868592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.42659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-13T08:44:39.868626Z","caller":"traceutil/trace.go:171","msg":"trace[985159969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5340; }","duration":"180.496601ms","start":"2026-08-13T08:44:39.688118Z","end":"2026-08-13T08:44:39.868614Z","steps":["trace[985159969] 'agreement among raft nodes before linearized reading' (duration: 180.335507ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:39.869314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.262456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-13T08:44:39.869431Z","caller":"traceutil/trace.go:171","msg":"trace[1897927738] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5340; }","duration":"163.251241ms","start":"2026-08-13T08:44:39.706151Z","end":"2026-08-13T08:44:39.869402Z","steps":["trace[1897927738] 'agreement among raft nodes before linearized reading' (duration: 162.118432ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:51.296342Z","caller":"traceutil/trace.go:171","msg":"trace[547247511] transaction","detail":"{read_only:false; response_revision:5562; number_of_response:1; }","duration":"224.823895ms","start":"2026-08-13T08:44:51.071485Z","end":"2026-08-13T08:44:51.296309Z","steps":["trace[547247511] 'process raft request' (duration: 224.516987ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:51.302752Z","caller":"traceutil/trace.go:171","msg":"trace[563703193] linearizableReadLoop","detail":"{readStateIndex:5771; appliedIndex:5769; }","duration":"141.986207ms","start":"2026-08-13T08:44:51.160746Z","end":"2026-08-13T08:44:51.302732Z","steps":["trace[563703193] 'read index received' (duration: 135.246572ms)","trace[563703193] 'applied index is now lower than readState.Index' (duration: 6.738645ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:51.302794Z","caller":"traceutil/trace.go:171","msg":"trace[1579444383] transaction","detail":"{read_only:false; response_revision:5563; number_of_response:1; }","duration":"146.905015ms","start":"2026-08-13T08:44:51.155874Z","end":"2026-08-13T08:44:51.302779Z","steps":["trace[1579444383] 'process raft request' (duration: 146.72441ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:51.302968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.210284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bgt8w\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-08-13T08:44:51.303034Z","caller":"traceutil/trace.go:171","msg":"trace[82863726] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bgt8w; range_end:; response_count:1; response_revision:5563; }","duration":"142.323357ms","start":"2026-08-13T08:44:51.160696Z","end":"2026-08-13T08:44:51.30302Z","steps":["trace[82863726] 'agreement among raft nodes before linearized reading' (duration: 142.116272ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:51.3409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.081657ms","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-08-13T08:44:51.341001Z","caller":"traceutil/trace.go:171","msg":"trace[163102445] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5564; }","duration":"143.23006ms","start":"2026-08-13T08:44:51.197749Z","end":"2026-08-13T08:44:51.340979Z","steps":["trace[163102445] 'agreement among raft nodes before linearized reading' (duration: 142.912902ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:51.3409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.232224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/goldpinger-xt5vd\" ","response":"range_response_count:1 size:4995"} {"level":"info","ts":"2026-08-13T08:44:51.341108Z","caller":"traceutil/trace.go:171","msg":"trace[576687872] range","detail":"{range_begin:/registry/pods/monitoring/goldpinger-xt5vd; range_end:; response_count:1; response_revision:5564; }","duration":"122.434049ms","start":"2026-08-13T08:44:51.21864Z","end":"2026-08-13T08:44:51.341074Z","steps":["trace[576687872] 'agreement among raft nodes before linearized reading' (duration: 122.018858ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:51.645677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.989762ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:44:51.646008Z","caller":"traceutil/trace.go:171","msg":"trace[1738958357] transaction","detail":"{read_only:false; response_revision:5566; number_of_response:1; }","duration":"300.484906ms","start":"2026-08-13T08:44:51.345501Z","end":"2026-08-13T08:44:51.645986Z","steps":["trace[1738958357] 'process raft request' (duration: 300.283241ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:51.646083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:51.345468Z","time spent":"300.573058ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:44:51.646145Z","caller":"traceutil/trace.go:171","msg":"trace[467914548] transaction","detail":"{read_only:false; response_revision:5565; number_of_response:1; }","duration":"300.837825ms","start":"2026-08-13T08:44:51.345277Z","end":"2026-08-13T08:44:51.646115Z","steps":["trace[467914548] 'process raft request' (duration: 25.34255ms)","trace[467914548] 'compare' (duration: 274.737946ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:44:51.646298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:51.345244Z","time spent":"300.971489ms","remote":"127.0.0.1:43682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":524,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:44:51.646378Z","caller":"traceutil/trace.go:171","msg":"trace[2015933997] transaction","detail":"{read_only:false; response_revision:5567; number_of_response:1; }","duration":"300.526207ms","start":"2026-08-13T08:44:51.34584Z","end":"2026-08-13T08:44:51.646366Z","steps":["trace[2015933997] 'process raft request' (duration: 300.036325ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:51.64644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:51.345832Z","time spent":"300.574418ms","remote":"127.0.0.1:43792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1005,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:44:51.646593Z","caller":"traceutil/trace.go:171","msg":"trace[2144727218] transaction","detail":"{read_only:false; response_revision:5568; number_of_response:1; }","duration":"296.283737ms","start":"2026-08-13T08:44:51.350268Z","end":"2026-08-13T08:44:51.646551Z","steps":["trace[2144727218] 'process raft request' (duration: 295.656521ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:52.069987Z","caller":"traceutil/trace.go:171","msg":"trace[1081761938] transaction","detail":"{read_only:false; response_revision:5578; number_of_response:1; }","duration":"174.622878ms","start":"2026-08-13T08:44:51.895334Z","end":"2026-08-13T08:44:52.069957Z","steps":["trace[1081761938] 'process raft request' (duration: 174.544476ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:52.070635Z","caller":"traceutil/trace.go:171","msg":"trace[1193289212] transaction","detail":"{read_only:false; response_revision:5576; number_of_response:1; }","duration":"176.911949ms","start":"2026-08-13T08:44:51.893708Z","end":"2026-08-13T08:44:52.07062Z","steps":["trace[1193289212] 'process raft request' (duration: 175.874341ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:52.070998Z","caller":"traceutil/trace.go:171","msg":"trace[180732675] transaction","detail":"{read_only:false; response_revision:5577; number_of_response:1; }","duration":"177.129755ms","start":"2026-08-13T08:44:51.893824Z","end":"2026-08-13T08:44:52.070954Z","steps":["trace[180732675] 'process raft request' (duration: 175.955473ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:52.690158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.928839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:44:52.690551Z","caller":"traceutil/trace.go:171","msg":"trace[1316055544] linearizableReadLoop","detail":"{readStateIndex:5787; appliedIndex:5783; }","duration":"742.963441ms","start":"2026-08-13T08:44:51.947566Z","end":"2026-08-13T08:44:52.69053Z","steps":["trace[1316055544] 'read index received' (duration: 121.966206ms)","trace[1316055544] 'applied index is now lower than readState.Index' (duration: 620.996375ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:44:52.69066Z","caller":"traceutil/trace.go:171","msg":"trace[417506576] transaction","detail":"{read_only:false; response_revision:5580; number_of_response:1; }","duration":"719.308485ms","start":"2026-08-13T08:44:51.971343Z","end":"2026-08-13T08:44:52.690651Z","steps":["trace[417506576] 'process raft request' (duration: 718.914625ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:52.69077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.196587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:44:52.6908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.155119ms","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-08-13T08:44:52.690811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:51.971325Z","time spent":"719.356717ms","remote":"127.0.0.1:43778","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-08-13T08:44:52.690855Z","caller":"traceutil/trace.go:171","msg":"trace[1034273596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5580; }","duration":"743.308439ms","start":"2026-08-13T08:44:51.947523Z","end":"2026-08-13T08:44:52.690831Z","steps":["trace[1034273596] 'agreement among raft nodes before linearized reading' (duration: 743.162856ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:52.690852Z","caller":"traceutil/trace.go:171","msg":"trace[43565969] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5580; }","duration":"717.259541ms","start":"2026-08-13T08:44:51.973576Z","end":"2026-08-13T08:44:52.690835Z","steps":["trace[43565969] 'agreement among raft nodes before linearized reading' (duration: 717.098237ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:52.690863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.683638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-08-13T08:44:52.690898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:51.947507Z","time spent":"743.383892ms","remote":"127.0.0.1:43500","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-08-13T08:44:52.690971Z","caller":"traceutil/trace.go:171","msg":"trace[544172083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5580; }","duration":"698.855492ms","start":"2026-08-13T08:44:51.992083Z","end":"2026-08-13T08:44:52.690938Z","steps":["trace[544172083] 'agreement among raft nodes before linearized reading' (duration: 698.589905ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:52.690985Z","caller":"traceutil/trace.go:171","msg":"trace[1670896827] transaction","detail":"{read_only:false; response_revision:5579; number_of_response:1; }","duration":"749.965183ms","start":"2026-08-13T08:44:51.940359Z","end":"2026-08-13T08:44:52.690324Z","steps":["trace[1670896827] 'process raft request' (duration: 610.786058ms)","trace[1670896827] 'compare' (duration: 138.795635ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:44:52.691029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.113105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-13T08:44:52.691099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:51.940328Z","time spent":"750.735333ms","remote":"127.0.0.1:43778","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-08-13T08:44:52.691059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.106817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-08-13T08:44:52.690903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:51.973545Z","time spent":"717.349664ms","remote":"127.0.0.1:43778","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-08-13T08:44:52.691144Z","caller":"traceutil/trace.go:171","msg":"trace[265060518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5580; }","duration":"700.28286ms","start":"2026-08-13T08:44:51.990836Z","end":"2026-08-13T08:44:52.691119Z","steps":["trace[265060518] 'agreement among raft nodes before linearized reading' (duration: 699.92074ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:52.691176Z","caller":"traceutil/trace.go:171","msg":"trace[346329862] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5580; }","duration":"712.260852ms","start":"2026-08-13T08:44:51.978889Z","end":"2026-08-13T08:44:52.69115Z","steps":["trace[346329862] 'agreement among raft nodes before linearized reading' (duration: 711.887572ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:52.691243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:51.978877Z","time spent":"712.353554ms","remote":"127.0.0.1:43778","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-08-13T08:44:52.691254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:51.990828Z","time spent":"700.413273ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-13T08:44:52.690856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.423058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:44:52.691503Z","caller":"traceutil/trace.go:171","msg":"trace[671658439] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:5580; }","duration":"682.117976ms","start":"2026-08-13T08:44:52.00936Z","end":"2026-08-13T08:44:52.691478Z","steps":["trace[671658439] 'agreement among raft nodes before linearized reading' (duration: 681.343076ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:44:52.691012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:51.992078Z","time spent":"698.926544ms","remote":"127.0.0.1:43778","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-08-13T08:44:52.691577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:52.009342Z","time spent":"682.216408ms","remote":"127.0.0.1:43708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":48,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-08-13T08:44:52.915974Z","caller":"traceutil/trace.go:171","msg":"trace[935956452] transaction","detail":"{read_only:false; response_revision:5581; number_of_response:1; }","duration":"219.853716ms","start":"2026-08-13T08:44:52.696085Z","end":"2026-08-13T08:44:52.915939Z","steps":["trace[935956452] 'process raft request' (duration: 219.611829ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:52.916897Z","caller":"traceutil/trace.go:171","msg":"trace[1692458954] linearizableReadLoop","detail":"{readStateIndex:5792; appliedIndex:5788; }","duration":"134.204665ms","start":"2026-08-13T08:44:52.782661Z","end":"2026-08-13T08:44:52.916866Z","steps":["trace[1692458954] 'read index received' (duration: 133.055885ms)","trace[1692458954] 'applied index is now lower than readState.Index' (duration: 1.14566ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:44:52.91709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.41563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:44:52.917221Z","caller":"traceutil/trace.go:171","msg":"trace[1060141735] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:5584; }","duration":"134.614616ms","start":"2026-08-13T08:44:52.782594Z","end":"2026-08-13T08:44:52.917208Z","steps":["trace[1060141735] 'agreement among raft nodes before linearized reading' (duration: 134.404101ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:52.917089Z","caller":"traceutil/trace.go:171","msg":"trace[1312873835] transaction","detail":"{read_only:false; response_revision:5584; number_of_response:1; }","duration":"220.146853ms","start":"2026-08-13T08:44:52.696916Z","end":"2026-08-13T08:44:52.917063Z","steps":["trace[1312873835] 'process raft request' (duration: 219.765884ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:52.916608Z","caller":"traceutil/trace.go:171","msg":"trace[1910861153] transaction","detail":"{read_only:false; response_revision:5582; number_of_response:1; }","duration":"220.107712ms","start":"2026-08-13T08:44:52.696091Z","end":"2026-08-13T08:44:52.916198Z","steps":["trace[1910861153] 'process raft request' (duration: 219.776104ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:44:52.916741Z","caller":"traceutil/trace.go:171","msg":"trace[729585392] transaction","detail":"{read_only:false; response_revision:5583; number_of_response:1; }","duration":"220.169825ms","start":"2026-08-13T08:44:52.696551Z","end":"2026-08-13T08:44:52.916721Z","steps":["trace[729585392] 'process raft request' (duration: 219.99871ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:00.271927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.035267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:45:00.27202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.246005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7727931e-441a-428c-ad70-1f8659dc791a\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-13T08:45:00.272054Z","caller":"traceutil/trace.go:171","msg":"trace[1748395983] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5758; }","duration":"322.224653ms","start":"2026-08-13T08:44:59.949796Z","end":"2026-08-13T08:45:00.272021Z","steps":["trace[1748395983] 'range keys from in-memory index tree' (duration: 321.915105ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:00.272123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:44:59.949768Z","time spent":"322.341035ms","remote":"127.0.0.1:43500","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-08-13T08:45:00.272121Z","caller":"traceutil/trace.go:171","msg":"trace[2076298990] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7727931e-441a-428c-ad70-1f8659dc791a; range_end:; response_count:1; response_revision:5758; }","duration":"233.412749ms","start":"2026-08-13T08:45:00.038685Z","end":"2026-08-13T08:45:00.272098Z","steps":["trace[2076298990] 'range keys from in-memory index tree' (duration: 232.935027ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:45:00.274219Z","caller":"traceutil/trace.go:171","msg":"trace[1079086755] transaction","detail":"{read_only:false; response_revision:5759; number_of_response:1; }","duration":"205.863352ms","start":"2026-08-13T08:45:00.06831Z","end":"2026-08-13T08:45:00.274173Z","steps":["trace[1079086755] 'process raft request' (duration: 205.516993ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:45:00.739415Z","caller":"traceutil/trace.go:171","msg":"trace[135810122] linearizableReadLoop","detail":"{readStateIndex:5973; appliedIndex:5972; }","duration":"337.344536ms","start":"2026-08-13T08:45:00.402034Z","end":"2026-08-13T08:45:00.739378Z","steps":["trace[135810122] 'read index received' (duration: 337.154231ms)","trace[135810122] 'applied index is now lower than readState.Index' (duration: 188.675µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:45:00.739594Z","caller":"traceutil/trace.go:171","msg":"trace[1341682669] transaction","detail":"{read_only:false; response_revision:5760; number_of_response:1; }","duration":"374.130224ms","start":"2026-08-13T08:45:00.365418Z","end":"2026-08-13T08:45:00.739548Z","steps":["trace[1341682669] 'process raft request' (duration: 373.730384ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:00.739718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.662414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-13T08:45:00.739767Z","caller":"traceutil/trace.go:171","msg":"trace[1685559826] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5760; }","duration":"337.792897ms","start":"2026-08-13T08:45:00.401962Z","end":"2026-08-13T08:45:00.739755Z","steps":["trace[1685559826] 'agreement among raft nodes before linearized reading' (duration: 337.577702ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:00.739815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:45:00.401935Z","time spent":"337.87079ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-13T08:45:00.73993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:45:00.36539Z","time spent":"374.34602ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:45:00.831571Z","caller":"traceutil/trace.go:171","msg":"trace[805036285] transaction","detail":"{read_only:false; response_revision:5761; number_of_response:1; }","duration":"108.145437ms","start":"2026-08-13T08:45:00.723382Z","end":"2026-08-13T08:45:00.831528Z","steps":["trace[805036285] 'process raft request' (duration: 107.856129ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:45:00.831678Z","caller":"traceutil/trace.go:171","msg":"trace[413170109] transaction","detail":"{read_only:false; response_revision:5762; number_of_response:1; }","duration":"107.255273ms","start":"2026-08-13T08:45:00.724354Z","end":"2026-08-13T08:45:00.83161Z","steps":["trace[413170109] 'process raft request' (duration: 107.096389ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:00.831798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.644397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2318"} {"level":"info","ts":"2026-08-13T08:45:00.831877Z","caller":"traceutil/trace.go:171","msg":"trace[1973272558] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5762; }","duration":"288.809022ms","start":"2026-08-13T08:45:00.543049Z","end":"2026-08-13T08:45:00.831858Z","steps":["trace[1973272558] 'agreement among raft nodes before linearized reading' (duration: 288.532745ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:01.027391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.294581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:45:01.027443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.711809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:4791"} {"level":"info","ts":"2026-08-13T08:45:01.027487Z","caller":"traceutil/trace.go:171","msg":"trace[37455946] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5762; }","duration":"118.455775ms","start":"2026-08-13T08:45:00.909009Z","end":"2026-08-13T08:45:01.027465Z","steps":["trace[37455946] 'range keys from in-memory index tree' (duration: 118.192378ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:45:01.027508Z","caller":"traceutil/trace.go:171","msg":"trace[1308992869] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5762; }","duration":"187.833983ms","start":"2026-08-13T08:45:00.839659Z","end":"2026-08-13T08:45:01.027493Z","steps":["trace[1308992869] 'range keys from in-memory index tree' (duration: 187.525054ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:45:02.603588Z","caller":"traceutil/trace.go:171","msg":"trace[1099493147] linearizableReadLoop","detail":"{readStateIndex:5996; appliedIndex:5995; }","duration":"136.750951ms","start":"2026-08-13T08:45:02.466814Z","end":"2026-08-13T08:45:02.603565Z","steps":["trace[1099493147] 'read index received' (duration: 116.37787ms)","trace[1099493147] 'applied index is now lower than readState.Index' (duration: 20.371981ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:45:02.60369Z","caller":"traceutil/trace.go:171","msg":"trace[1461322959] transaction","detail":"{read_only:false; response_revision:5783; number_of_response:1; }","duration":"165.354366ms","start":"2026-08-13T08:45:02.438317Z","end":"2026-08-13T08:45:02.603672Z","steps":["trace[1461322959] 'process raft request' (duration: 144.79278ms)","trace[1461322959] 'compare' (duration: 20.296298ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:45:02.603842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.016969ms","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-08-13T08:45:02.603886Z","caller":"traceutil/trace.go:171","msg":"trace[2045279265] 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:5783; }","duration":"137.118052ms","start":"2026-08-13T08:45:02.466756Z","end":"2026-08-13T08:45:02.603874Z","steps":["trace[2045279265] 'agreement among raft nodes before linearized reading' (duration: 136.917646ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:45:05.243133Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2939} {"level":"info","ts":"2026-08-13T08:45:05.323736Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2939,"took":"78.715931ms","hash":4067831764,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":32133120,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-13T08:45:05.323825Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4067831764,"revision":2939,"compact-revision":-1} {"level":"warn","ts":"2026-08-13T08:45:07.077779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.162287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:45:07.078163Z","caller":"traceutil/trace.go:171","msg":"trace[718780195] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5845; }","duration":"136.635859ms","start":"2026-08-13T08:45:06.941502Z","end":"2026-08-13T08:45:07.078138Z","steps":["trace[718780195] 'count revisions from in-memory index tree' (duration: 136.013452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:51.472051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.63337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:45:51.472189Z","caller":"traceutil/trace.go:171","msg":"trace[272028250] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:6225; }","duration":"272.804634ms","start":"2026-08-13T08:45:51.199354Z","end":"2026-08-13T08:45:51.472158Z","steps":["trace[272028250] 'range keys from in-memory index tree' (duration: 272.582428ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:51.472469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.714338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:45:51.4725Z","caller":"traceutil/trace.go:171","msg":"trace[1978544824] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:6225; }","duration":"273.76589ms","start":"2026-08-13T08:45:51.198726Z","end":"2026-08-13T08:45:51.472492Z","steps":["trace[1978544824] 'range keys from in-memory index tree' (duration: 273.654877ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:51.47268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.754511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6084"} {"level":"info","ts":"2026-08-13T08:45:51.47277Z","caller":"traceutil/trace.go:171","msg":"trace[1996038114] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:6225; }","duration":"270.870225ms","start":"2026-08-13T08:45:51.20188Z","end":"2026-08-13T08:45:51.47275Z","steps":["trace[1996038114] 'range keys from in-memory index tree' (duration: 270.553626ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:51.472969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.184206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-08-13T08:45:51.473142Z","caller":"traceutil/trace.go:171","msg":"trace[1729410732] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:6225; }","duration":"275.863564ms","start":"2026-08-13T08:45:51.197248Z","end":"2026-08-13T08:45:51.473112Z","steps":["trace[1729410732] 'range keys from in-memory index tree' (duration: 274.9709ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:45:51.481777Z","caller":"traceutil/trace.go:171","msg":"trace[1399868612] transaction","detail":"{read_only:false; response_revision:6226; number_of_response:1; }","duration":"214.433974ms","start":"2026-08-13T08:45:51.26732Z","end":"2026-08-13T08:45:51.481754Z","steps":["trace[1399868612] 'process raft request' (duration: 213.832749ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:45:51.774519Z","caller":"traceutil/trace.go:171","msg":"trace[863536723] transaction","detail":"{read_only:false; response_revision:6233; number_of_response:1; }","duration":"114.41323ms","start":"2026-08-13T08:45:51.660068Z","end":"2026-08-13T08:45:51.774481Z","steps":["trace[863536723] 'process raft request' (duration: 93.31724ms)","trace[863536723] 'compare' (duration: 20.697369ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:45:59.685951Z","caller":"traceutil/trace.go:171","msg":"trace[769853332] transaction","detail":"{read_only:false; response_revision:6300; number_of_response:1; }","duration":"143.395544ms","start":"2026-08-13T08:45:59.542517Z","end":"2026-08-13T08:45:59.685913Z","steps":["trace[769853332] 'process raft request' (duration: 116.002591ms)","trace[769853332] 'compare' (duration: 27.051785ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:45:59.686371Z","caller":"traceutil/trace.go:171","msg":"trace[1040745880] linearizableReadLoop","detail":"{readStateIndex:6529; appliedIndex:6528; }","duration":"139.919684ms","start":"2026-08-13T08:45:59.546429Z","end":"2026-08-13T08:45:59.686348Z","steps":["trace[1040745880] 'read index received' (duration: 111.655848ms)","trace[1040745880] 'applied index is now lower than readState.Index' (duration: 28.261876ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:45:59.68666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.210117ms","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-08-13T08:45:59.686662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.213901ms","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-08-13T08:45:59.686701Z","caller":"traceutil/trace.go:171","msg":"trace[1594077832] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6301; }","duration":"136.320519ms","start":"2026-08-13T08:45:59.550366Z","end":"2026-08-13T08:45:59.686686Z","steps":["trace[1594077832] 'agreement among raft nodes before linearized reading' (duration: 136.149725ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:45:59.686716Z","caller":"traceutil/trace.go:171","msg":"trace[1546003375] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6301; }","duration":"140.320984ms","start":"2026-08-13T08:45:59.546382Z","end":"2026-08-13T08:45:59.686703Z","steps":["trace[1546003375] 'agreement among raft nodes before linearized reading' (duration: 140.131719ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:45:59.686779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.459698ms","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-08-13T08:45:59.686883Z","caller":"traceutil/trace.go:171","msg":"trace[1460151516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6301; }","duration":"135.593351ms","start":"2026-08-13T08:45:59.551263Z","end":"2026-08-13T08:45:59.686857Z","steps":["trace[1460151516] 'agreement among raft nodes before linearized reading' (duration: 135.321374ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:50:05.250075Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5838} {"level":"info","ts":"2026-08-13T08:50:05.331083Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5838,"took":"78.777726ms","hash":4258683093,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":26873856,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-13T08:50:05.331159Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4258683093,"revision":5838,"compact-revision":2939} {"level":"info","ts":"2026-08-13T08:51:26.74055Z","caller":"traceutil/trace.go:171","msg":"trace[550913057] linearizableReadLoop","detail":"{readStateIndex:8973; appliedIndex:8972; }","duration":"273.114039ms","start":"2026-08-13T08:51:26.467406Z","end":"2026-08-13T08:51:26.74052Z","steps":["trace[550913057] 'read index received' (duration: 272.965655ms)","trace[550913057] 'applied index is now lower than readState.Index' (duration: 147.144µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:51:26.740699Z","caller":"traceutil/trace.go:171","msg":"trace[134310114] transaction","detail":"{read_only:false; response_revision:8666; number_of_response:1; }","duration":"373.54501ms","start":"2026-08-13T08:51:26.367102Z","end":"2026-08-13T08:51:26.740647Z","steps":["trace[134310114] 'process raft request' (duration: 373.217212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:26.74076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.323735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:51:26.7408Z","caller":"traceutil/trace.go:171","msg":"trace[497607884] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8666; }","duration":"273.454218ms","start":"2026-08-13T08:51:26.467335Z","end":"2026-08-13T08:51:26.74079Z","steps":["trace[497607884] 'agreement among raft nodes before linearized reading' (duration: 273.305224ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:26.740909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:51:26.367067Z","time spent":"373.730705ms","remote":"127.0.0.1:43778","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-08-13T08:51:26.84638Z","caller":"traceutil/trace.go:171","msg":"trace[1839438575] transaction","detail":"{read_only:false; response_revision:8667; number_of_response:1; }","duration":"360.249962ms","start":"2026-08-13T08:51:26.486083Z","end":"2026-08-13T08:51:26.846333Z","steps":["trace[1839438575] 'process raft request' (duration: 306.504489ms)","trace[1839438575] 'compare' (duration: 53.570358ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:51:26.846679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:51:26.486059Z","time spent":"360.495438ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:51:27.637621Z","caller":"traceutil/trace.go:171","msg":"trace[1035798969] transaction","detail":"{read_only:false; response_revision:8670; number_of_response:1; }","duration":"138.730912ms","start":"2026-08-13T08:51:27.498849Z","end":"2026-08-13T08:51:27.63758Z","steps":["trace[1035798969] 'process raft request' (duration: 138.425154ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:28.023819Z","caller":"traceutil/trace.go:171","msg":"trace[1187497049] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"381.339903ms","start":"2026-08-13T08:51:27.642451Z","end":"2026-08-13T08:51:28.023791Z","steps":["trace[1187497049] 'process raft request' (duration: 381.148998ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:28.024021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:51:27.642424Z","time spent":"381.501856ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:51:28.039675Z","caller":"traceutil/trace.go:171","msg":"trace[1695201963] linearizableReadLoop","detail":"{readStateIndex:8980; appliedIndex:8977; }","duration":"303.739307ms","start":"2026-08-13T08:51:27.735914Z","end":"2026-08-13T08:51:28.039654Z","steps":["trace[1695201963] 'read index received' (duration: 287.772891ms)","trace[1695201963] 'applied index is now lower than readState.Index' (duration: 15.965816ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:51:28.039731Z","caller":"traceutil/trace.go:171","msg":"trace[652387606] transaction","detail":"{read_only:false; response_revision:8672; number_of_response:1; }","duration":"396.154849ms","start":"2026-08-13T08:51:27.643544Z","end":"2026-08-13T08:51:28.039699Z","steps":["trace[652387606] 'process raft request' (duration: 395.945003ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:28.039812Z","caller":"traceutil/trace.go:171","msg":"trace[1724066446] transaction","detail":"{read_only:false; response_revision:8673; number_of_response:1; }","duration":"394.945188ms","start":"2026-08-13T08:51:27.644811Z","end":"2026-08-13T08:51:28.039756Z","steps":["trace[1724066446] 'process raft request' (duration: 394.809205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:28.039898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:51:27.643508Z","time spent":"396.296572ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:51:28.039932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.008994ms","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-08-13T08:51:28.039957Z","caller":"traceutil/trace.go:171","msg":"trace[1453756277] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8673; }","duration":"304.101266ms","start":"2026-08-13T08:51:27.735848Z","end":"2026-08-13T08:51:28.039949Z","steps":["trace[1453756277] 'agreement among raft nodes before linearized reading' (duration: 303.931912ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:28.039983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:51:27.735818Z","time spent":"304.160278ms","remote":"127.0.0.1:43778","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":"warn","ts":"2026-08-13T08:51:28.040039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:51:27.644765Z","time spent":"395.157433ms","remote":"127.0.0.1:43778","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-08-13T08:51:28.040165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.713975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bgt8w\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-08-13T08:51:28.040193Z","caller":"traceutil/trace.go:171","msg":"trace[1344636278] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bgt8w; range_end:; response_count:1; response_revision:8673; }","duration":"170.780337ms","start":"2026-08-13T08:51:27.869404Z","end":"2026-08-13T08:51:28.040185Z","steps":["trace[1344636278] 'agreement among raft nodes before linearized reading' (duration: 170.630772ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:29.017359Z","caller":"traceutil/trace.go:171","msg":"trace[1505344958] transaction","detail":"{read_only:false; response_revision:8677; number_of_response:1; }","duration":"164.900814ms","start":"2026-08-13T08:51:28.852424Z","end":"2026-08-13T08:51:29.017325Z","steps":["trace[1505344958] 'process raft request' (duration: 164.664998ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:29.034357Z","caller":"traceutil/trace.go:171","msg":"trace[2121504048] transaction","detail":"{read_only:false; response_revision:8678; number_of_response:1; }","duration":"105.745679ms","start":"2026-08-13T08:51:28.928567Z","end":"2026-08-13T08:51:29.034313Z","steps":["trace[2121504048] 'process raft request' (duration: 105.507973ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:41.723264Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002368.wal"} {"level":"info","ts":"2026-08-13T08:51:56.220816Z","caller":"traceutil/trace.go:171","msg":"trace[1713944767] transaction","detail":"{read_only:false; response_revision:8875; number_of_response:1; }","duration":"426.45122ms","start":"2026-08-13T08:51:55.79433Z","end":"2026-08-13T08:51:56.220781Z","steps":["trace[1713944767] 'process raft request' (duration: 426.220704ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:56.221024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:51:55.794297Z","time spent":"426.627435ms","remote":"127.0.0.1:43778","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-08-13T08:51:56.375886Z","caller":"traceutil/trace.go:171","msg":"trace[1234885613] linearizableReadLoop","detail":"{readStateIndex:9191; appliedIndex:9189; }","duration":"205.876323ms","start":"2026-08-13T08:51:56.16998Z","end":"2026-08-13T08:51:56.375856Z","steps":["trace[1234885613] 'read index received' (duration: 50.634901ms)","trace[1234885613] 'applied index is now lower than readState.Index' (duration: 155.240132ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:51:56.376096Z","caller":"traceutil/trace.go:171","msg":"trace[1050221395] transaction","detail":"{read_only:false; response_revision:8876; number_of_response:1; }","duration":"253.972599ms","start":"2026-08-13T08:51:56.122073Z","end":"2026-08-13T08:51:56.376045Z","steps":["trace[1050221395] 'process raft request' (duration: 248.62005ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:56.376216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.220653ms","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-08-13T08:51:56.37626Z","caller":"traceutil/trace.go:171","msg":"trace[687503704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8876; }","duration":"206.284435ms","start":"2026-08-13T08:51:56.16996Z","end":"2026-08-13T08:51:56.376244Z","steps":["trace[687503704] 'agreement among raft nodes before linearized reading' (duration: 206.069228ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:56.376452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.301029ms","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-08-13T08:51:56.376487Z","caller":"traceutil/trace.go:171","msg":"trace[572568029] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8876; }","duration":"141.380491ms","start":"2026-08-13T08:51:56.235099Z","end":"2026-08-13T08:51:56.376479Z","steps":["trace[572568029] 'agreement among raft nodes before linearized reading' (duration: 141.294899ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:56.376569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.575088ms","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-08-13T08:51:56.376637Z","caller":"traceutil/trace.go:171","msg":"trace[2133949900] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8876; }","duration":"202.702602ms","start":"2026-08-13T08:51:56.173918Z","end":"2026-08-13T08:51:56.376621Z","steps":["trace[2133949900] 'agreement among raft nodes before linearized reading' (duration: 202.483306ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:56.37666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.156034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bgt8w\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-08-13T08:51:56.376998Z","caller":"traceutil/trace.go:171","msg":"trace[1513487780] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bgt8w; range_end:; response_count:1; response_revision:8876; }","duration":"123.551935ms","start":"2026-08-13T08:51:56.253426Z","end":"2026-08-13T08:51:56.376977Z","steps":["trace[1513487780] 'agreement among raft nodes before linearized reading' (duration: 122.99879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:56.376758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.097059ms","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-08-13T08:51:56.377109Z","caller":"traceutil/trace.go:171","msg":"trace[1008853714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8876; }","duration":"201.502509ms","start":"2026-08-13T08:51:56.17558Z","end":"2026-08-13T08:51:56.377082Z","steps":["trace[1008853714] 'agreement among raft nodes before linearized reading' (duration: 200.883333ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:01.134977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.164322ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:52:01.135088Z","caller":"traceutil/trace.go:171","msg":"trace[1363386966] transaction","detail":"{read_only:false; response_revision:8900; number_of_response:1; }","duration":"712.488943ms","start":"2026-08-13T08:52:00.422579Z","end":"2026-08-13T08:52:01.135068Z","steps":["trace[1363386966] 'process raft request' (duration: 235.133267ms)","trace[1363386966] 'compare' (duration: 477.029428ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:52:01.13514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:00.422546Z","time spent":"712.568065ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:52:01.137912Z","caller":"traceutil/trace.go:171","msg":"trace[1574441324] linearizableReadLoop","detail":"{readStateIndex:9218; appliedIndex:9216; }","duration":"706.352873ms","start":"2026-08-13T08:52:00.431511Z","end":"2026-08-13T08:52:01.137864Z","steps":["trace[1574441324] 'read index received' (duration: 226.111261ms)","trace[1574441324] 'applied index is now lower than readState.Index' (duration: 480.240142ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:52:01.138069Z","caller":"traceutil/trace.go:171","msg":"trace[120986650] transaction","detail":"{read_only:false; response_revision:8901; number_of_response:1; }","duration":"706.814875ms","start":"2026-08-13T08:52:00.431212Z","end":"2026-08-13T08:52:01.138027Z","steps":["trace[120986650] 'process raft request' (duration: 706.449366ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:01.138277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:00.431181Z","time spent":"706.98064ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:52:01.138685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.142455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:227521"} {"level":"info","ts":"2026-08-13T08:52:01.138751Z","caller":"traceutil/trace.go:171","msg":"trace[1231362543] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8901; }","duration":"707.237397ms","start":"2026-08-13T08:52:00.431496Z","end":"2026-08-13T08:52:01.138734Z","steps":["trace[1231362543] 'agreement among raft nodes before linearized reading' (duration: 706.524268ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:01.138797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:00.431479Z","time spent":"707.307709ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":26,"response size":227545,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-08-13T08:52:01.703476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.545604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:52:01.703908Z","caller":"traceutil/trace.go:171","msg":"trace[1596054149] transaction","detail":"{read_only:false; response_revision:8903; number_of_response:1; }","duration":"572.993118ms","start":"2026-08-13T08:52:01.130893Z","end":"2026-08-13T08:52:01.703886Z","steps":["trace[1596054149] 'process raft request' (duration: 572.806453ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:52:01.703868Z","caller":"traceutil/trace.go:171","msg":"trace[55456302] transaction","detail":"{read_only:false; response_revision:8902; number_of_response:1; }","duration":"807.611029ms","start":"2026-08-13T08:52:00.896176Z","end":"2026-08-13T08:52:01.703787Z","steps":["trace[55456302] 'process raft request' (duration: 409.11869ms)","trace[55456302] 'compare' (duration: 396.710733ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:52:01.704045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:01.130864Z","time spent":"573.125201ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:52:01.70424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:00.896147Z","time spent":"807.955818ms","remote":"127.0.0.1:43778","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-08-13T08:52:01.712033Z","caller":"traceutil/trace.go:171","msg":"trace[2147326919] transaction","detail":"{read_only:false; response_revision:8905; number_of_response:1; }","duration":"561.147989ms","start":"2026-08-13T08:52:01.150857Z","end":"2026-08-13T08:52:01.712005Z","steps":["trace[2147326919] 'process raft request' (duration: 561.103368ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:52:01.712091Z","caller":"traceutil/trace.go:171","msg":"trace[58582180] transaction","detail":"{read_only:false; response_revision:8904; number_of_response:1; }","duration":"565.657917ms","start":"2026-08-13T08:52:01.146414Z","end":"2026-08-13T08:52:01.712072Z","steps":["trace[58582180] 'process raft request' (duration: 565.423021ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:01.712179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:01.146388Z","time spent":"565.738699ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:52:01.712194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:01.150831Z","time spent":"561.276703ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:52:01.730256Z","caller":"traceutil/trace.go:171","msg":"trace[1106999084] linearizableReadLoop","detail":"{readStateIndex:9223; appliedIndex:9220; }","duration":"169.198842ms","start":"2026-08-13T08:52:01.561018Z","end":"2026-08-13T08:52:01.730217Z","steps":["trace[1106999084] 'read index received' (duration: 150.864093ms)","trace[1106999084] 'applied index is now lower than readState.Index' (duration: 18.333189ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:52:01.730402Z","caller":"traceutil/trace.go:171","msg":"trace[45183490] transaction","detail":"{read_only:false; response_revision:8906; number_of_response:1; }","duration":"257.152154ms","start":"2026-08-13T08:52:01.473206Z","end":"2026-08-13T08:52:01.730359Z","steps":["trace[45183490] 'process raft request' (duration: 256.822366ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:01.730552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.439718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:52:01.73061Z","caller":"traceutil/trace.go:171","msg":"trace[1072334229] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:8906; }","duration":"169.645873ms","start":"2026-08-13T08:52:01.560947Z","end":"2026-08-13T08:52:01.730593Z","steps":["trace[1072334229] 'agreement among raft nodes before linearized reading' (duration: 169.457359ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:09.979927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.034239ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-13T08:52:09.980032Z","caller":"traceutil/trace.go:171","msg":"trace[1221656209] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8985; }","duration":"484.760088ms","start":"2026-08-13T08:52:09.495258Z","end":"2026-08-13T08:52:09.980018Z","steps":["trace[1221656209] 'process raft request' (duration: 33.490703ms)","trace[1221656209] 'compare' (duration: 450.752491ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:52:09.980085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:09.495241Z","time spent":"484.821059ms","remote":"127.0.0.1:48110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80,"response count":0,"response size":42,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-08-13T08:52:09.995065Z","caller":"traceutil/trace.go:171","msg":"trace[246777256] transaction","detail":"{read_only:false; response_revision:8986; number_of_response:1; }","duration":"496.709929ms","start":"2026-08-13T08:52:09.498303Z","end":"2026-08-13T08:52:09.995013Z","steps":["trace[246777256] 'process raft request' (duration: 496.482503ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:09.995312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:09.498264Z","time spent":"496.921754ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4633,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:52:10.521128Z","caller":"traceutil/trace.go:171","msg":"trace[1923597279] transaction","detail":"{read_only:false; response_revision:8988; number_of_response:1; }","duration":"786.591178ms","start":"2026-08-13T08:52:09.734512Z","end":"2026-08-13T08:52:10.521104Z","steps":["trace[1923597279] 'process raft request' (duration: 786.432614ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:52:10.521113Z","caller":"traceutil/trace.go:171","msg":"trace[645314848] transaction","detail":"{read_only:false; response_revision:8989; number_of_response:1; }","duration":"783.122487ms","start":"2026-08-13T08:52:09.737952Z","end":"2026-08-13T08:52:10.521075Z","steps":["trace[645314848] 'process raft request' (duration: 783.046725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:10.521299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:09.734493Z","time spent":"786.718411ms","remote":"127.0.0.1:43778","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-08-13T08:52:10.521321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:09.737912Z","time spent":"783.304452ms","remote":"127.0.0.1:43778","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-08-13T08:52:10.521128Z","caller":"traceutil/trace.go:171","msg":"trace[1199077611] transaction","detail":"{read_only:false; response_revision:8987; number_of_response:1; }","duration":"788.000905ms","start":"2026-08-13T08:52:09.733094Z","end":"2026-08-13T08:52:10.521095Z","steps":["trace[1199077611] 'process raft request' (duration: 787.622485ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:52:10.521324Z","caller":"traceutil/trace.go:171","msg":"trace[997550657] linearizableReadLoop","detail":"{readStateIndex:9312; appliedIndex:9307; }","duration":"572.31512ms","start":"2026-08-13T08:52:09.948973Z","end":"2026-08-13T08:52:10.521288Z","steps":["trace[997550657] 'read index received' (duration: 45.818074ms)","trace[997550657] 'applied index is now lower than readState.Index' (duration: 526.494746ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:52:10.521377Z","caller":"traceutil/trace.go:171","msg":"trace[645904000] transaction","detail":"{read_only:false; response_revision:8990; number_of_response:1; }","duration":"782.978803ms","start":"2026-08-13T08:52:09.73834Z","end":"2026-08-13T08:52:10.521318Z","steps":["trace[645904000] 'process raft request' (duration: 782.692386ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:10.521539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:09.733062Z","time spent":"788.352844ms","remote":"127.0.0.1:43778","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-08-13T08:52:10.521631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.631268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:52:10.521615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:09.738325Z","time spent":"783.25559ms","remote":"127.0.0.1:43778","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-08-13T08:52:10.52173Z","caller":"traceutil/trace.go:171","msg":"trace[148759860] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8990; }","duration":"572.798743ms","start":"2026-08-13T08:52:09.948917Z","end":"2026-08-13T08:52:10.521716Z","steps":["trace[148759860] 'agreement among raft nodes before linearized reading' (duration: 572.639309ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:10.521935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:09.94889Z","time spent":"572.973767ms","remote":"127.0.0.1:43500","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-08-13T08:52:10.571202Z","caller":"traceutil/trace.go:171","msg":"trace[1496146490] transaction","detail":"{read_only:false; response_revision:8991; number_of_response:1; }","duration":"523.729124ms","start":"2026-08-13T08:52:10.047433Z","end":"2026-08-13T08:52:10.571162Z","steps":["trace[1496146490] 'process raft request' (duration: 523.366764ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:52:10.57141Z","caller":"traceutil/trace.go:171","msg":"trace[1394393897] transaction","detail":"{read_only:false; response_revision:8992; number_of_response:1; }","duration":"504.301837ms","start":"2026-08-13T08:52:10.067078Z","end":"2026-08-13T08:52:10.57138Z","steps":["trace[1394393897] 'process raft request' (duration: 503.951188ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:10.571574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:10.067065Z","time spent":"504.42868ms","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T08:52:10.572013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.419738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-13T08:52:10.572063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.257873ms","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-08-13T08:52:10.572214Z","caller":"traceutil/trace.go:171","msg":"trace[1416966733] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8993; }","duration":"113.447238ms","start":"2026-08-13T08:52:10.458754Z","end":"2026-08-13T08:52:10.572201Z","steps":["trace[1416966733] 'agreement among raft nodes before linearized reading' (duration: 113.15459ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:10.572236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.877649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-d7q6k\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-08-13T08:52:10.572266Z","caller":"traceutil/trace.go:171","msg":"trace[1477147687] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-d7q6k; range_end:; response_count:1; response_revision:8993; }","duration":"505.943831ms","start":"2026-08-13T08:52:10.066311Z","end":"2026-08-13T08:52:10.572255Z","steps":["trace[1477147687] 'agreement among raft nodes before linearized reading' (duration: 505.867759ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:10.572298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:10.06627Z","time spent":"506.019883ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":4672,"request content":"key:\"/registry/pods/openstack/rook-ceph-detect-version-d7q6k\" "} {"level":"info","ts":"2026-08-13T08:52:10.572076Z","caller":"traceutil/trace.go:171","msg":"trace[82540135] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8993; }","duration":"250.530751ms","start":"2026-08-13T08:52:10.32153Z","end":"2026-08-13T08:52:10.572061Z","steps":["trace[82540135] 'agreement among raft nodes before linearized reading' (duration: 250.421148ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:10.572018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:10.047407Z","time spent":"523.96743ms","remote":"127.0.0.1:43778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:52:10.572162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.425667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-13T08:52:10.574948Z","caller":"traceutil/trace.go:171","msg":"trace[388849463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8993; }","duration":"266.232801ms","start":"2026-08-13T08:52:10.308681Z","end":"2026-08-13T08:52:10.574913Z","steps":["trace[388849463] 'agreement among raft nodes before linearized reading' (duration: 263.415398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:10.575157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.193387ms","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-08-13T08:52:10.575267Z","caller":"traceutil/trace.go:171","msg":"trace[323859451] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8993; }","duration":"104.36086ms","start":"2026-08-13T08:52:10.470862Z","end":"2026-08-13T08:52:10.575222Z","steps":["trace[323859451] 'agreement among raft nodes before linearized reading' (duration: 101.548347ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:10.575487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.351276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-d7q6k\" ","response":"range_response_count:1 size:4648"} {"level":"warn","ts":"2026-08-13T08:52:10.575547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.343954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-13T08:52:10.575626Z","caller":"traceutil/trace.go:171","msg":"trace[1662910586] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-d7q6k; range_end:; response_count:1; response_revision:8993; }","duration":"576.52413ms","start":"2026-08-13T08:52:09.999049Z","end":"2026-08-13T08:52:10.575573Z","steps":["trace[1662910586] 'agreement among raft nodes before linearized reading' (duration: 573.322817ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:52:10.575663Z","caller":"traceutil/trace.go:171","msg":"trace[1713519040] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8993; }","duration":"561.512388ms","start":"2026-08-13T08:52:10.014131Z","end":"2026-08-13T08:52:10.575643Z","steps":["trace[1713519040] 'agreement among raft nodes before linearized reading' (duration: 558.355496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:10.575692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:09.999028Z","time spent":"576.651904ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":4672,"request content":"key:\"/registry/pods/openstack/rook-ceph-detect-version-d7q6k\" "} {"level":"warn","ts":"2026-08-13T08:52:10.575772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:10.014102Z","time spent":"561.620991ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-13T08:52:11.268179Z","caller":"traceutil/trace.go:171","msg":"trace[125570250] transaction","detail":"{read_only:false; response_revision:8998; number_of_response:1; }","duration":"152.056064ms","start":"2026-08-13T08:52:11.116074Z","end":"2026-08-13T08:52:11.26813Z","steps":["trace[125570250] 'process raft request' (duration: 151.764417ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:11.649242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.833787ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:52:11.649387Z","caller":"traceutil/trace.go:171","msg":"trace[1332389287] transaction","detail":"{read_only:false; response_revision:8999; number_of_response:1; }","duration":"377.115832ms","start":"2026-08-13T08:52:11.272248Z","end":"2026-08-13T08:52:11.649364Z","steps":["trace[1332389287] 'process raft request' (duration: 207.050398ms)","trace[1332389287] 'compare' (duration: 169.423567ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:52:11.649459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:11.27222Z","time spent":"377.208684ms","remote":"127.0.0.1:43778","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-08-13T08:52:11.678187Z","caller":"traceutil/trace.go:171","msg":"trace[534812170] linearizableReadLoop","detail":"{readStateIndex:9322; appliedIndex:9320; }","duration":"404.897627ms","start":"2026-08-13T08:52:11.273254Z","end":"2026-08-13T08:52:11.678152Z","steps":["trace[534812170] 'read index received' (duration: 206.064113ms)","trace[534812170] 'applied index is now lower than readState.Index' (duration: 198.832494ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:52:11.678271Z","caller":"traceutil/trace.go:171","msg":"trace[302199496] transaction","detail":"{read_only:false; response_revision:9001; number_of_response:1; }","duration":"289.580681ms","start":"2026-08-13T08:52:11.388655Z","end":"2026-08-13T08:52:11.678235Z","steps":["trace[302199496] 'process raft request' (duration: 289.447327ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:52:11.678227Z","caller":"traceutil/trace.go:171","msg":"trace[1063958429] transaction","detail":"{read_only:false; response_revision:9000; number_of_response:1; }","duration":"405.171454ms","start":"2026-08-13T08:52:11.273021Z","end":"2026-08-13T08:52:11.678192Z","steps":["trace[1063958429] 'process raft request' (duration: 404.903367ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:11.678446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:11.272996Z","time spent":"405.362828ms","remote":"127.0.0.1:43778","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-08-13T08:52:11.678605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.264594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-config-override\" ","response":"range_response_count:1 size:626"} {"level":"info","ts":"2026-08-13T08:52:11.67866Z","caller":"traceutil/trace.go:171","msg":"trace[1837416845] range","detail":"{range_begin:/registry/configmaps/openstack/rook-config-override; range_end:; response_count:1; response_revision:9001; }","duration":"403.387476ms","start":"2026-08-13T08:52:11.275258Z","end":"2026-08-13T08:52:11.678645Z","steps":["trace[1837416845] 'agreement among raft nodes before linearized reading' (duration: 403.104559ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:11.678705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:11.275247Z","time spent":"403.448028ms","remote":"127.0.0.1:43616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":650,"request content":"key:\"/registry/configmaps/openstack/rook-config-override\" "} {"level":"warn","ts":"2026-08-13T08:52:11.678824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.554243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:227436"} {"level":"info","ts":"2026-08-13T08:52:11.678904Z","caller":"traceutil/trace.go:171","msg":"trace[2110678605] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:9001; }","duration":"405.636815ms","start":"2026-08-13T08:52:11.273248Z","end":"2026-08-13T08:52:11.678885Z","steps":["trace[2110678605] 'agreement among raft nodes before linearized reading' (duration: 405.04943ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:11.678963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:11.273215Z","time spent":"405.733798ms","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":26,"response size":227460,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-08-13T08:52:12.265006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.096877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:52:12.265147Z","caller":"traceutil/trace.go:171","msg":"trace[119721566] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:9003; }","duration":"154.269802ms","start":"2026-08-13T08:52:12.110841Z","end":"2026-08-13T08:52:12.265111Z","steps":["trace[119721566] 'range keys from in-memory index tree' (duration: 153.972385ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:52:12.574964Z","caller":"traceutil/trace.go:171","msg":"trace[587651988] transaction","detail":"{read_only:false; response_revision:9005; number_of_response:1; }","duration":"195.533148ms","start":"2026-08-13T08:52:12.379394Z","end":"2026-08-13T08:52:12.574927Z","steps":["trace[587651988] 'process raft request' (duration: 195.059346ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:53:13.722909Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-13T08:53:13.731208Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-13T08:53:13.731288Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-08-13T08:53:30.483678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.406613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:53:30.483838Z","caller":"traceutil/trace.go:171","msg":"trace[1879267069] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:9757; }","duration":"119.607278ms","start":"2026-08-13T08:53:30.364185Z","end":"2026-08-13T08:53:30.483792Z","steps":["trace[1879267069] 'count revisions from in-memory index tree' (duration: 119.192638ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:55:05.264994Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8008} {"level":"info","ts":"2026-08-13T08:55:05.327336Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8008,"took":"60.168519ms","hash":498861139,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":28065792,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-13T08:55:05.327391Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":498861139,"revision":8008,"compact-revision":5838} {"level":"info","ts":"2026-08-13T08:55:21.852413Z","caller":"traceutil/trace.go:171","msg":"trace[1574095235] transaction","detail":"{read_only:false; response_revision:10565; number_of_response:1; }","duration":"114.00469ms","start":"2026-08-13T08:55:21.738383Z","end":"2026-08-13T08:55:21.852388Z","steps":["trace[1574095235] 'process raft request' (duration: 113.843716ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:55:21.853877Z","caller":"traceutil/trace.go:171","msg":"trace[1257341636] transaction","detail":"{read_only:false; response_revision:10566; number_of_response:1; }","duration":"114.929235ms","start":"2026-08-13T08:55:21.738923Z","end":"2026-08-13T08:55:21.853852Z","steps":["trace[1257341636] 'process raft request' (duration: 114.806002ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T09:00:05.270781Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10422} {"level":"info","ts":"2026-08-13T09:00:05.354991Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10422,"took":"82.075478ms","hash":3878522531,"current-db-size-bytes":57262080,"current-db-size":"57 MB","current-db-size-in-use-bytes":21168128,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-08-13T09:00:05.355082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3878522531,"revision":10422,"compact-revision":8008}