{"level":"warn","ts":"2026-06-02T06:47:15.957105Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T06:47:15.957271Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.161:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.161:2380","--initial-cluster=instance=https://199.19.213.161:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.161:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.161: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-06-02T06:47:15.957392Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T06:47:15.957403Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.161:2380"]} {"level":"info","ts":"2026-06-02T06:47:15.957437Z","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-06-02T06:47:15.962438Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.161:2379"]} {"level":"info","ts":"2026-06-02T06:47:15.962546Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.161:2380"],"listen-peer-urls":["https://199.19.213.161:2380"],"advertise-client-urls":["https://199.19.213.161:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.161:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.161: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-06-02T06:47:15.967778Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.953591ms"} {"level":"info","ts":"2026-06-02T06:47:15.976801Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2460b0ba85bf91ab","cluster-id":"c077309761674c46"} {"level":"info","ts":"2026-06-02T06:47:15.976898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab switched to configuration voters=()"} {"level":"info","ts":"2026-06-02T06:47:15.976929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became follower at term 0"} {"level":"info","ts":"2026-06-02T06:47:15.97694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2460b0ba85bf91ab [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-02T06:47:15.976952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became follower at term 1"} {"level":"info","ts":"2026-06-02T06:47:15.976992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab switched to configuration voters=(2621289298283958699)"} {"level":"warn","ts":"2026-06-02T06:47:15.986114Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-02T06:47:15.987725Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-02T06:47:15.988899Z","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-06-02T06:47:15.990956Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2460b0ba85bf91ab","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-02T06:47:15.999117Z","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-06-02T06:47:16.000923Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2460b0ba85bf91ab","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-02T06:47:16.001015Z","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-06-02T06:47:16.001094Z","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-06-02T06:47:16.001116Z","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-06-02T06:47:16.002971Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.161:2380"} {"level":"info","ts":"2026-06-02T06:47:16.002996Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.161:2380"} {"level":"info","ts":"2026-06-02T06:47:16.003199Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2460b0ba85bf91ab","initial-advertise-peer-urls":["https://199.19.213.161:2380"],"listen-peer-urls":["https://199.19.213.161:2380"],"advertise-client-urls":["https://199.19.213.161:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.161:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-02T06:47:16.003234Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-02T06:47:16.006239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab switched to configuration voters=(2621289298283958699)"} {"level":"info","ts":"2026-06-02T06:47:16.006341Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c077309761674c46","local-member-id":"2460b0ba85bf91ab","added-peer-id":"2460b0ba85bf91ab","added-peer-peer-urls":["https://199.19.213.161:2380"]} {"level":"info","ts":"2026-06-02T06:47:16.677942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab is starting a new election at term 1"} {"level":"info","ts":"2026-06-02T06:47:16.678004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became pre-candidate at term 1"} {"level":"info","ts":"2026-06-02T06:47:16.678025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab received MsgPreVoteResp from 2460b0ba85bf91ab at term 1"} {"level":"info","ts":"2026-06-02T06:47:16.678035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became candidate at term 2"} {"level":"info","ts":"2026-06-02T06:47:16.67804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab received MsgVoteResp from 2460b0ba85bf91ab at term 2"} {"level":"info","ts":"2026-06-02T06:47:16.678048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became leader at term 2"} {"level":"info","ts":"2026-06-02T06:47:16.678057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2460b0ba85bf91ab elected leader 2460b0ba85bf91ab at term 2"} {"level":"info","ts":"2026-06-02T06:47:16.67927Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:47:16.680274Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T06:47:16.68029Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T06:47:16.680276Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2460b0ba85bf91ab","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.161:2379]}","request-path":"/0/members/2460b0ba85bf91ab/attributes","cluster-id":"c077309761674c46","publish-timeout":"7s"} {"level":"info","ts":"2026-06-02T06:47:16.68064Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-02T06:47:16.680696Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-02T06:47:16.680902Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c077309761674c46","local-member-id":"2460b0ba85bf91ab","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:47:16.681011Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:47:16.681066Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:47:16.682194Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.161:2379"} {"level":"info","ts":"2026-06-02T06:47:16.683588Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-02T06:47:18.352293Z","caller":"traceutil/trace.go:171","msg":"trace[426648598] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"202.285585ms","start":"2026-06-02T06:47:18.149978Z","end":"2026-06-02T06:47:18.352263Z","steps":["trace[426648598] 'process raft request' (duration: 202.009773ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:18.848735Z","caller":"traceutil/trace.go:171","msg":"trace[1340617883] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"694.720108ms","start":"2026-06-02T06:47:18.153974Z","end":"2026-06-02T06:47:18.848694Z","steps":["trace[1340617883] 'process raft request' (duration: 694.599614ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:18.848856Z","caller":"traceutil/trace.go:171","msg":"trace[483903272] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"696.927779ms","start":"2026-06-02T06:47:18.151903Z","end":"2026-06-02T06:47:18.84883Z","steps":["trace[483903272] 'read index received' (duration: 200.122374ms)","trace[483903272] 'applied index is now lower than readState.Index' (duration: 496.804165ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:47:18.848984Z","caller":"traceutil/trace.go:171","msg":"trace[7491606] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"617.754179ms","start":"2026-06-02T06:47:18.23122Z","end":"2026-06-02T06:47:18.848975Z","steps":["trace[7491606] 'process raft request' (duration: 617.422394ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:18.84906Z","caller":"traceutil/trace.go:171","msg":"trace[1688959030] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"617.77034ms","start":"2026-06-02T06:47:18.231281Z","end":"2026-06-02T06:47:18.849052Z","steps":["trace[1688959030] 'process raft request' (duration: 617.403204ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:18.849101Z","caller":"traceutil/trace.go:171","msg":"trace[1437062690] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"617.746939ms","start":"2026-06-02T06:47:18.231347Z","end":"2026-06-02T06:47:18.849094Z","steps":["trace[1437062690] 'process raft request' (duration: 617.363942ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:18.849145Z","caller":"traceutil/trace.go:171","msg":"trace[100588175] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"617.791131ms","start":"2026-06-02T06:47:18.231343Z","end":"2026-06-02T06:47:18.849134Z","steps":["trace[100588175] 'process raft request' (duration: 617.391763ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:18.849183Z","caller":"traceutil/trace.go:171","msg":"trace[1324850301] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"613.883998ms","start":"2026-06-02T06:47:18.235292Z","end":"2026-06-02T06:47:18.849176Z","steps":["trace[1324850301] 'process raft request' (duration: 613.475031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:18.84949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.538507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T06:47:18.849588Z","caller":"traceutil/trace.go:171","msg":"trace[1888723052] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"568.679063ms","start":"2026-06-02T06:47:18.280895Z","end":"2026-06-02T06:47:18.849574Z","steps":["trace[1888723052] 'agreement among raft nodes before linearized reading' (duration: 568.544277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:18.849635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.280879Z","time spent":"568.747516ms","remote":"127.0.0.1:49496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-02T06:47:18.849663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.735113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-02T06:47:18.84964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.694322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T06:47:18.849706Z","caller":"traceutil/trace.go:171","msg":"trace[655702239] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"603.480635ms","start":"2026-06-02T06:47:18.246186Z","end":"2026-06-02T06:47:18.849667Z","steps":["trace[655702239] 'process raft request' (duration: 602.612298ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:18.849737Z","caller":"traceutil/trace.go:171","msg":"trace[133236357] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"697.821948ms","start":"2026-06-02T06:47:18.151892Z","end":"2026-06-02T06:47:18.849713Z","steps":["trace[133236357] 'agreement among raft nodes before linearized reading' (duration: 697.686192ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:18.849746Z","caller":"traceutil/trace.go:171","msg":"trace[1445263] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"620.805426ms","start":"2026-06-02T06:47:18.228926Z","end":"2026-06-02T06:47:18.849731Z","steps":["trace[1445263] 'agreement among raft nodes before linearized reading' (duration: 620.691112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:18.849783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.151888Z","time spent":"697.88758ms","remote":"127.0.0.1:49392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T06:47:18.849814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.368496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T06:47:18.84983Z","caller":"traceutil/trace.go:171","msg":"trace[1959895541] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"289.44686ms","start":"2026-06-02T06:47:18.560377Z","end":"2026-06-02T06:47:18.849823Z","steps":["trace[1959895541] 'agreement among raft nodes before linearized reading' (duration: 289.428349ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:18.849519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.268221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"warn","ts":"2026-06-02T06:47:18.849818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.228918Z","time spent":"620.889879ms","remote":"127.0.0.1:49496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-02T06:47:18.849915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.637765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T06:47:18.84995Z","caller":"traceutil/trace.go:171","msg":"trace[903328576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"694.690997ms","start":"2026-06-02T06:47:18.155252Z","end":"2026-06-02T06:47:18.849943Z","steps":["trace[903328576] 'agreement among raft nodes before linearized reading' (duration: 694.640695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:18.849979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.155245Z","time spent":"694.726738ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T06:47:18.850058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.227619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-02T06:47:18.849796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.285674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T06:47:18.850104Z","caller":"traceutil/trace.go:171","msg":"trace[1327989833] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"695.312112ms","start":"2026-06-02T06:47:18.15478Z","end":"2026-06-02T06:47:18.850092Z","steps":["trace[1327989833] 'agreement among raft nodes before linearized reading' (duration: 695.188207ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:18.850129Z","caller":"traceutil/trace.go:171","msg":"trace[1099268970] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"549.632698ms","start":"2026-06-02T06:47:18.300487Z","end":"2026-06-02T06:47:18.85012Z","steps":["trace[1099268970] 'agreement among raft nodes before linearized reading' (duration: 549.289874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:18.850135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.154766Z","time spent":"695.361845ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T06:47:18.85017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.300474Z","time spent":"549.687311ms","remote":"127.0.0.1:49496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-02T06:47:18.849592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.403406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T06:47:18.850344Z","caller":"traceutil/trace.go:171","msg":"trace[516023248] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"619.168128ms","start":"2026-06-02T06:47:18.231163Z","end":"2026-06-02T06:47:18.850331Z","steps":["trace[516023248] 'agreement among raft nodes before linearized reading' (duration: 618.406547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:18.850392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.231149Z","time spent":"619.22742ms","remote":"127.0.0.1:49464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-06-02T06:47:18.850531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.153956Z","time spent":"694.871004ms","remote":"127.0.0.1:49636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:47:18.84949Z","caller":"traceutil/trace.go:171","msg":"trace[1922106264] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"618.296471ms","start":"2026-06-02T06:47:18.231143Z","end":"2026-06-02T06:47:18.84944Z","steps":["trace[1922106264] 'process raft request' (duration: 617.466346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:18.851479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.231112Z","time spent":"620.253123ms","remote":"127.0.0.1:49814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:47:18.84986Z","caller":"traceutil/trace.go:171","msg":"trace[347052907] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"695.680849ms","start":"2026-06-02T06:47:18.154169Z","end":"2026-06-02T06:47:18.84985Z","steps":["trace[347052907] 'agreement among raft nodes before linearized reading' (duration: 695.21724ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:18.84874Z","caller":"traceutil/trace.go:171","msg":"trace[1111918612] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"697.41932ms","start":"2026-06-02T06:47:18.151296Z","end":"2026-06-02T06:47:18.848715Z","steps":["trace[1111918612] 'process raft request' (duration: 697.135849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:18.85013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.798447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.161\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-02T06:47:18.850633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.2312Z","time spent":"617.830872ms","remote":"127.0.0.1:49876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:47:18.850652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.231271Z","time spent":"617.816012ms","remote":"127.0.0.1:49876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:47:18.850669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.231332Z","time spent":"617.794891ms","remote":"127.0.0.1:49876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:47:18.850687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.231327Z","time spent":"617.842663ms","remote":"127.0.0.1:49876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:47:18.850705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.235276Z","time spent":"613.92487ms","remote":"127.0.0.1:49876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:47:18.85072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.246173Z","time spent":"603.567528ms","remote":"127.0.0.1:49560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:47:18.85258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.154134Z","time spent":"698.403062ms","remote":"127.0.0.1:49560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-02T06:47:18.852748Z","caller":"traceutil/trace.go:171","msg":"trace[52707656] range","detail":"{range_begin:/registry/masterleases/199.19.213.161; range_end:; response_count:0; response_revision:11; }","duration":"624.456788ms","start":"2026-06-02T06:47:18.228272Z","end":"2026-06-02T06:47:18.852729Z","steps":["trace[52707656] 'agreement among raft nodes before linearized reading' (duration: 621.829669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:18.853784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.228225Z","time spent":"625.550983ms","remote":"127.0.0.1:49418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.161\" "} {"level":"warn","ts":"2026-06-02T06:47:18.852913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:18.151283Z","time spent":"701.335744ms","remote":"127.0.0.1:49430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:47:19.5113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.867689ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:47:19.511458Z","caller":"traceutil/trace.go:171","msg":"trace[937337834] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"152.214834ms","start":"2026-06-02T06:47:19.35922Z","end":"2026-06-02T06:47:19.511435Z","steps":["trace[937337834] 'compare' (duration: 150.622109ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:19.684713Z","caller":"traceutil/trace.go:171","msg":"trace[152936844] transaction","detail":"{read_only:false; response_revision:157; number_of_response:1; }","duration":"135.332868ms","start":"2026-06-02T06:47:19.549355Z","end":"2026-06-02T06:47:19.684688Z","steps":["trace[152936844] 'process raft request' (duration: 80.229647ms)","trace[152936844] 'compare' (duration: 54.996887ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:47:19.908582Z","caller":"traceutil/trace.go:171","msg":"trace[438672641] transaction","detail":"{read_only:false; response_revision:162; number_of_response:1; }","duration":"132.21014ms","start":"2026-06-02T06:47:19.77634Z","end":"2026-06-02T06:47:19.90855Z","steps":["trace[438672641] 'process raft request' (duration: 46.716555ms)","trace[438672641] 'compare' (duration: 85.260785ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:47:20.740794Z","caller":"traceutil/trace.go:171","msg":"trace[362825242] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"340.800227ms","start":"2026-06-02T06:47:20.399965Z","end":"2026-06-02T06:47:20.740765Z","steps":["trace[362825242] 'process raft request' (duration: 331.683266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:20.740962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:20.399955Z","time spent":"340.928713ms","remote":"127.0.0.1:49722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":764,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:47:22.351256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.003383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-02T06:47:22.351376Z","caller":"traceutil/trace.go:171","msg":"trace[1085410311] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:269; }","duration":"105.157799ms","start":"2026-06-02T06:47:22.246195Z","end":"2026-06-02T06:47:22.351353Z","steps":["trace[1085410311] 'range keys from in-memory index tree' (duration: 104.92265ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:24.134257Z","caller":"traceutil/trace.go:171","msg":"trace[1481322154] transaction","detail":"{read_only:false; number_of_response:0; response_revision:319; }","duration":"128.001674ms","start":"2026-06-02T06:47:24.006229Z","end":"2026-06-02T06:47:24.134231Z","steps":["trace[1481322154] 'process raft request' (duration: 127.90542ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:24.174663Z","caller":"traceutil/trace.go:171","msg":"trace[1427484075] transaction","detail":"{read_only:false; number_of_response:0; response_revision:319; }","duration":"166.029845ms","start":"2026-06-02T06:47:24.008611Z","end":"2026-06-02T06:47:24.174641Z","steps":["trace[1427484075] 'process raft request' (duration: 165.510264ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:24.175049Z","caller":"traceutil/trace.go:171","msg":"trace[619128143] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"157.397648ms","start":"2026-06-02T06:47:24.017623Z","end":"2026-06-02T06:47:24.17502Z","steps":["trace[619128143] 'process raft request' (duration: 156.614057ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:24.175101Z","caller":"traceutil/trace.go:171","msg":"trace[382006660] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"128.749073ms","start":"2026-06-02T06:47:24.046331Z","end":"2026-06-02T06:47:24.17508Z","steps":["trace[382006660] 'process raft request' (duration: 127.976542ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:24.175139Z","caller":"traceutil/trace.go:171","msg":"trace[213364615] transaction","detail":"{read_only:false; number_of_response:0; response_revision:319; }","duration":"166.388399ms","start":"2026-06-02T06:47:24.008727Z","end":"2026-06-02T06:47:24.175115Z","steps":["trace[213364615] 'process raft request' (duration: 165.489663ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:24.175508Z","caller":"traceutil/trace.go:171","msg":"trace[1319606190] transaction","detail":"{read_only:false; number_of_response:0; response_revision:319; }","duration":"166.119658ms","start":"2026-06-02T06:47:24.008696Z","end":"2026-06-02T06:47:24.174815Z","steps":["trace[1319606190] 'process raft request' (duration: 165.499033ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:25.183938Z","caller":"traceutil/trace.go:171","msg":"trace[1855922361] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"189.619215ms","start":"2026-06-02T06:47:24.994291Z","end":"2026-06-02T06:47:25.183911Z","steps":["trace[1855922361] 'process raft request' (duration: 119.09517ms)","trace[1855922361] 'compare' (duration: 70.326658ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:47:25.184134Z","caller":"traceutil/trace.go:171","msg":"trace[673360173] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"189.825603ms","start":"2026-06-02T06:47:24.994283Z","end":"2026-06-02T06:47:25.184109Z","steps":["trace[673360173] 'process raft request' (duration: 189.586653ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:25.184117Z","caller":"traceutil/trace.go:171","msg":"trace[1096683769] linearizableReadLoop","detail":"{readStateIndex:351; appliedIndex:349; }","duration":"101.83443ms","start":"2026-06-02T06:47:25.082247Z","end":"2026-06-02T06:47:25.184081Z","steps":["trace[1096683769] 'read index received' (duration: 31.149469ms)","trace[1096683769] 'applied index is now lower than readState.Index' (duration: 70.68245ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:47:25.184334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.050009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:47:25.184391Z","caller":"traceutil/trace.go:171","msg":"trace[274276507] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:0; response_revision:339; }","duration":"102.165483ms","start":"2026-06-02T06:47:25.082211Z","end":"2026-06-02T06:47:25.184377Z","steps":["trace[274276507] 'agreement among raft nodes before linearized reading' (duration: 102.005127ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:26.278585Z","caller":"traceutil/trace.go:171","msg":"trace[335459015] linearizableReadLoop","detail":"{readStateIndex:356; appliedIndex:355; }","duration":"131.978316ms","start":"2026-06-02T06:47:26.146577Z","end":"2026-06-02T06:47:26.278555Z","steps":["trace[335459015] 'read index received' (duration: 131.722675ms)","trace[335459015] 'applied index is now lower than readState.Index' (duration: 254.581µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:47:26.278614Z","caller":"traceutil/trace.go:171","msg":"trace[868523557] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"171.810592ms","start":"2026-06-02T06:47:26.106779Z","end":"2026-06-02T06:47:26.278589Z","steps":["trace[868523557] 'process raft request' (duration: 171.558563ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:26.278721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.131081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-06-02T06:47:26.278758Z","caller":"traceutil/trace.go:171","msg":"trace[276688353] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:344; }","duration":"132.224225ms","start":"2026-06-02T06:47:26.146524Z","end":"2026-06-02T06:47:26.278748Z","steps":["trace[276688353] 'agreement among raft nodes before linearized reading' (duration: 132.135412ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:26.385827Z","caller":"traceutil/trace.go:171","msg":"trace[1672794893] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"100.585869ms","start":"2026-06-02T06:47:26.285211Z","end":"2026-06-02T06:47:26.385797Z","steps":["trace[1672794893] 'process raft request' (duration: 100.277648ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:49.510731Z","caller":"traceutil/trace.go:171","msg":"trace[1762435420] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"179.527142ms","start":"2026-06-02T06:47:49.331162Z","end":"2026-06-02T06:47:49.510689Z","steps":["trace[1762435420] 'process raft request' (duration: 179.298495ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:49.513845Z","caller":"traceutil/trace.go:171","msg":"trace[1937429304] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"181.883822ms","start":"2026-06-02T06:47:49.331936Z","end":"2026-06-02T06:47:49.51382Z","steps":["trace[1937429304] 'process raft request' (duration: 181.760839ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:00.900649Z","caller":"traceutil/trace.go:171","msg":"trace[1925356479] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"605.817412ms","start":"2026-06-02T06:48:00.294799Z","end":"2026-06-02T06:48:00.900616Z","steps":["trace[1925356479] 'process raft request' (duration: 605.594747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:00.900866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.29478Z","time spent":"605.976597ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:48:00.993199Z","caller":"traceutil/trace.go:171","msg":"trace[1392829143] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"696.732356ms","start":"2026-06-02T06:48:00.296426Z","end":"2026-06-02T06:48:00.993158Z","steps":["trace[1392829143] 'process raft request' (duration: 696.211152ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:00.99331Z","caller":"traceutil/trace.go:171","msg":"trace[514309839] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"692.412291ms","start":"2026-06-02T06:48:00.300866Z","end":"2026-06-02T06:48:00.993278Z","steps":["trace[514309839] 'process raft request' (duration: 691.899366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:00.993358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.296408Z","time spent":"696.879971ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:48:00.993681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.30085Z","time spent":"692.543725ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:48:00.993689Z","caller":"traceutil/trace.go:171","msg":"trace[722239567] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"686.722927ms","start":"2026-06-02T06:48:00.30695Z","end":"2026-06-02T06:48:00.993673Z","steps":["trace[722239567] 'process raft request' (duration: 686.001547ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:00.993685Z","caller":"traceutil/trace.go:171","msg":"trace[58469053] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"692.789151ms","start":"2026-06-02T06:48:00.300864Z","end":"2026-06-02T06:48:00.993654Z","steps":["trace[58469053] 'process raft request' (duration: 691.843415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:00.993738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.306938Z","time spent":"686.775348ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:48:00.99377Z","caller":"traceutil/trace.go:171","msg":"trace[333210660] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"691.638409ms","start":"2026-06-02T06:48:00.302069Z","end":"2026-06-02T06:48:00.993707Z","steps":["trace[333210660] 'process raft request' (duration: 690.811076ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:00.993842Z","caller":"traceutil/trace.go:171","msg":"trace[790325060] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"684.383936ms","start":"2026-06-02T06:48:00.309449Z","end":"2026-06-02T06:48:00.993833Z","steps":["trace[790325060] 'process raft request' (duration: 683.617214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:00.993864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.300851Z","time spent":"692.908805ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:48:00.993901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.309442Z","time spent":"684.424896ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:48:00.993911Z","caller":"traceutil/trace.go:171","msg":"trace[317442129] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"674.51918ms","start":"2026-06-02T06:48:00.319324Z","end":"2026-06-02T06:48:00.993843Z","steps":["trace[317442129] 'process raft request' (duration: 673.906373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:00.993965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.302053Z","time spent":"691.821445ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:48:00.993983Z","caller":"traceutil/trace.go:171","msg":"trace[1685086827] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"656.29521ms","start":"2026-06-02T06:48:00.337678Z","end":"2026-06-02T06:48:00.993974Z","steps":["trace[1685086827] 'process raft request' (duration: 655.713015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:00.994049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.337659Z","time spent":"656.369813ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:48:00.993277Z","caller":"traceutil/trace.go:171","msg":"trace[1469539002] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"696.85532ms","start":"2026-06-02T06:48:00.296373Z","end":"2026-06-02T06:48:00.993228Z","steps":["trace[1469539002] 'process raft request' (duration: 696.076579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:00.994201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.319306Z","time spent":"674.708904ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:48:00.994248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.296352Z","time spent":"697.842026ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:48:00.994308Z","caller":"traceutil/trace.go:171","msg":"trace[5424393] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"641.504402ms","start":"2026-06-02T06:48:00.352788Z","end":"2026-06-02T06:48:00.994292Z","steps":["trace[5424393] 'process raft request' (duration: 640.920566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:00.994373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.352768Z","time spent":"641.573534ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:48:00.994642Z","caller":"traceutil/trace.go:171","msg":"trace[631839176] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:564; }","duration":"274.909938ms","start":"2026-06-02T06:48:00.719699Z","end":"2026-06-02T06:48:00.994609Z","steps":["trace[631839176] 'read index received' (duration: 180.153341ms)","trace[631839176] 'applied index is now lower than readState.Index' (duration: 94.755117ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:00.994707Z","caller":"traceutil/trace.go:171","msg":"trace[1995672812] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"519.359579ms","start":"2026-06-02T06:48:00.475325Z","end":"2026-06-02T06:48:00.994685Z","steps":["trace[1995672812] 'process raft request' (duration: 519.02309ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:00.994874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.167436ms","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-06-02T06:48:00.994955Z","caller":"traceutil/trace.go:171","msg":"trace[873261618] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:556; }","duration":"275.284628ms","start":"2026-06-02T06:48:00.719628Z","end":"2026-06-02T06:48:00.994912Z","steps":["trace[873261618] 'agreement among raft nodes before linearized reading' (duration: 275.093073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:00.995055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:00.475294Z","time spent":"519.589324ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:48:00.997703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.501166ms","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-06-02T06:48:00.997749Z","caller":"traceutil/trace.go:171","msg":"trace[1483447287] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:558; }","duration":"204.611359ms","start":"2026-06-02T06:48:00.793126Z","end":"2026-06-02T06:48:00.997738Z","steps":["trace[1483447287] 'agreement among raft nodes before linearized reading' (duration: 204.428724ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:07.481208Z","caller":"traceutil/trace.go:171","msg":"trace[2084800844] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"240.528476ms","start":"2026-06-02T06:48:07.240656Z","end":"2026-06-02T06:48:07.481184Z","steps":["trace[2084800844] 'process raft request' (duration: 240.398043ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:08.060174Z","caller":"traceutil/trace.go:171","msg":"trace[1255860278] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"765.005876ms","start":"2026-06-02T06:48:07.295147Z","end":"2026-06-02T06:48:08.060153Z","steps":["trace[1255860278] 'process raft request' (duration: 763.483279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:08.060468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:07.295094Z","time spent":"765.267214ms","remote":"127.0.0.1:49480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:48:08.060093Z","caller":"traceutil/trace.go:171","msg":"trace[61380260] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:680; }","duration":"435.243467ms","start":"2026-06-02T06:48:07.624822Z","end":"2026-06-02T06:48:08.060065Z","steps":["trace[61380260] 'read index received' (duration: 432.900248ms)","trace[61380260] 'applied index is now lower than readState.Index' (duration: 2.341969ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:48:08.259881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.908565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T06:48:08.259944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.125245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-02T06:48:08.260077Z","caller":"traceutil/trace.go:171","msg":"trace[1443853914] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:654; }","duration":"282.110819ms","start":"2026-06-02T06:48:07.977914Z","end":"2026-06-02T06:48:08.260024Z","steps":["trace[1443853914] 'agreement among raft nodes before linearized reading' (duration: 83.028591ms)","trace[1443853914] 'range keys from in-memory index tree' (duration: 198.891084ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:08.260139Z","caller":"traceutil/trace.go:171","msg":"trace[2115752190] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:654; }","duration":"635.321172ms","start":"2026-06-02T06:48:07.624763Z","end":"2026-06-02T06:48:08.260084Z","steps":["trace[2115752190] 'agreement among raft nodes before linearized reading' (duration: 435.73538ms)","trace[2115752190] 'range keys from in-memory index tree' (duration: 199.228312ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:48:08.260258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:07.624747Z","time spent":"635.439174ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T06:48:08.259881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.997688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T06:48:08.260385Z","caller":"traceutil/trace.go:171","msg":"trace[834725058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:654; }","duration":"596.524823ms","start":"2026-06-02T06:48:07.663843Z","end":"2026-06-02T06:48:08.260368Z","steps":["trace[834725058] 'agreement among raft nodes before linearized reading' (duration: 397.049284ms)","trace[834725058] 'range keys from in-memory index tree' (duration: 198.819092ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:48:08.260419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:07.663831Z","time spent":"596.575674ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-02T06:48:08.39214Z","caller":"traceutil/trace.go:171","msg":"trace[1012826998] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"273.983571ms","start":"2026-06-02T06:48:08.118132Z","end":"2026-06-02T06:48:08.392116Z","steps":["trace[1012826998] 'process raft request' (duration: 273.820347ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:08.424705Z","caller":"traceutil/trace.go:171","msg":"trace[1811755660] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"160.637217ms","start":"2026-06-02T06:48:08.264023Z","end":"2026-06-02T06:48:08.424661Z","steps":["trace[1811755660] 'process raft request' (duration: 160.263257ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:08.424796Z","caller":"traceutil/trace.go:171","msg":"trace[472431002] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"160.704948ms","start":"2026-06-02T06:48:08.264065Z","end":"2026-06-02T06:48:08.42477Z","steps":["trace[472431002] 'process raft request' (duration: 160.3498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:09.481941Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496657659546373745,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T06:48:09.982402Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496657659546373745,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T06:48:09.989855Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.163593822s","expected-duration":"1s"} {"level":"info","ts":"2026-06-02T06:48:09.994719Z","caller":"traceutil/trace.go:171","msg":"trace[294158190] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:685; }","duration":"1.013754135s","start":"2026-06-02T06:48:08.98094Z","end":"2026-06-02T06:48:09.994695Z","steps":["trace[294158190] 'read index received' (duration: 1.013744655s)","trace[294158190] 'applied index is now lower than readState.Index' (duration: 7.82µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:09.994721Z","caller":"traceutil/trace.go:171","msg":"trace[1538120039] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"1.16951136s","start":"2026-06-02T06:48:08.825186Z","end":"2026-06-02T06:48:09.994698Z","steps":["trace[1538120039] 'process raft request' (duration: 1.165171292s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:09.994837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.013878718s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:48:09.995041Z","caller":"traceutil/trace.go:171","msg":"trace[351280406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"1.014154014s","start":"2026-06-02T06:48:08.980874Z","end":"2026-06-02T06:48:09.995028Z","steps":["trace[351280406] 'agreement among raft nodes before linearized reading' (duration: 1.013910338s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:09.995051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:08.825156Z","time spent":"1.169757156s","remote":"127.0.0.1:49480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:48:09.995111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.425951ms","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-06-02T06:48:09.995142Z","caller":"traceutil/trace.go:171","msg":"trace[530711651] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:658; }","duration":"942.498993ms","start":"2026-06-02T06:48:09.052633Z","end":"2026-06-02T06:48:09.995132Z","steps":["trace[530711651] 'agreement among raft nodes before linearized reading' (duration: 942.35733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:09.995171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:09.052617Z","time spent":"942.548524ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T06:48:09.995087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:08.980839Z","time spent":"1.014237676s","remote":"127.0.0.1:49392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T06:48:09.995274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.121809ms","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-06-02T06:48:09.995371Z","caller":"traceutil/trace.go:171","msg":"trace[863207481] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:658; }","duration":"939.300143ms","start":"2026-06-02T06:48:09.056051Z","end":"2026-06-02T06:48:09.995351Z","steps":["trace[863207481] 'agreement among raft nodes before linearized reading' (duration: 938.997365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:09.995447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:09.056023Z","time spent":"939.382275ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-02T06:48:22.189973Z","caller":"traceutil/trace.go:171","msg":"trace[428341915] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"118.879674ms","start":"2026-06-02T06:48:22.071073Z","end":"2026-06-02T06:48:22.189953Z","steps":["trace[428341915] 'process raft request' (duration: 117.537875ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:24.782774Z","caller":"traceutil/trace.go:171","msg":"trace[526986769] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"103.042727ms","start":"2026-06-02T06:48:24.679696Z","end":"2026-06-02T06:48:24.782739Z","steps":["trace[526986769] 'process raft request' (duration: 75.295329ms)","trace[526986769] 'compare' (duration: 27.627255ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:48:25.827231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.113131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T06:48:25.82733Z","caller":"traceutil/trace.go:171","msg":"trace[2101363746] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:818; }","duration":"622.278404ms","start":"2026-06-02T06:48:25.20503Z","end":"2026-06-02T06:48:25.827309Z","steps":["trace[2101363746] 'count revisions from in-memory index tree' (duration: 621.936796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:25.827389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:25.205005Z","time spent":"622.367825ms","remote":"127.0.0.1:49852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:48:25.827562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.957034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-02T06:48:25.827539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.960936ms","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-06-02T06:48:25.827628Z","caller":"traceutil/trace.go:171","msg":"trace[854661270] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:818; }","duration":"551.067767ms","start":"2026-06-02T06:48:25.276545Z","end":"2026-06-02T06:48:25.827613Z","steps":["trace[854661270] 'count revisions from in-memory index tree' (duration: 550.871383ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:25.827644Z","caller":"traceutil/trace.go:171","msg":"trace[1009797927] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:818; }","duration":"891.073618ms","start":"2026-06-02T06:48:24.936554Z","end":"2026-06-02T06:48:25.827627Z","steps":["trace[1009797927] 'range keys from in-memory index tree' (duration: 890.948095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:25.827666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.839193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:48:25.827725Z","caller":"traceutil/trace.go:171","msg":"trace[669598055] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:818; }","duration":"724.957886ms","start":"2026-06-02T06:48:25.102753Z","end":"2026-06-02T06:48:25.827711Z","steps":["trace[669598055] 'count revisions from in-memory index tree' (duration: 724.71393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:25.827775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:25.102698Z","time spent":"725.063298ms","remote":"127.0.0.1:49688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:48:25.827674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:25.276522Z","time spent":"551.138429ms","remote":"127.0.0.1:49584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:48:25.827908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.632886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:48:25.828309Z","caller":"traceutil/trace.go:171","msg":"trace[331973811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:818; }","duration":"848.605678ms","start":"2026-06-02T06:48:24.979619Z","end":"2026-06-02T06:48:25.828225Z","steps":["trace[331973811] 'range keys from in-memory index tree' (duration: 847.551693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:25.8284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:24.9796Z","time spent":"848.785941ms","remote":"127.0.0.1:49392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-02T06:48:25.889445Z","caller":"traceutil/trace.go:171","msg":"trace[795119614] linearizableReadLoop","detail":"{readStateIndex:851; appliedIndex:850; }","duration":"148.701452ms","start":"2026-06-02T06:48:25.740732Z","end":"2026-06-02T06:48:25.889433Z","steps":["trace[795119614] 'read index received' (duration: 148.552619ms)","trace[795119614] 'applied index is now lower than readState.Index' (duration: 148.233µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:25.889509Z","caller":"traceutil/trace.go:171","msg":"trace[724283690] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"552.710752ms","start":"2026-06-02T06:48:25.336791Z","end":"2026-06-02T06:48:25.889502Z","steps":["trace[724283690] 'process raft request' (duration: 552.539449ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:25.889583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:48:25.33675Z","time spent":"552.779434ms","remote":"127.0.0.1:49624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:48:25.889828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.09729ms","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-06-02T06:48:25.889855Z","caller":"traceutil/trace.go:171","msg":"trace[1909957176] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:819; }","duration":"149.169452ms","start":"2026-06-02T06:48:25.740679Z","end":"2026-06-02T06:48:25.889849Z","steps":["trace[1909957176] 'agreement among raft nodes before linearized reading' (duration: 149.0867ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:26.040457Z","caller":"traceutil/trace.go:171","msg":"trace[734296222] linearizableReadLoop","detail":"{readStateIndex:852; appliedIndex:851; }","duration":"123.506218ms","start":"2026-06-02T06:48:25.916931Z","end":"2026-06-02T06:48:26.040437Z","steps":["trace[734296222] 'read index received' (duration: 111.5516ms)","trace[734296222] 'applied index is now lower than readState.Index' (duration: 11.953918ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:48:26.040747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.568999ms","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-06-02T06:48:26.040858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.912498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:48:26.040882Z","caller":"traceutil/trace.go:171","msg":"trace[242978022] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:820; }","duration":"123.973109ms","start":"2026-06-02T06:48:25.916904Z","end":"2026-06-02T06:48:26.040877Z","steps":["trace[242978022] 'agreement among raft nodes before linearized reading' (duration: 123.927948ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:26.04086Z","caller":"traceutil/trace.go:171","msg":"trace[1284453718] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:820; }","duration":"123.711132ms","start":"2026-06-02T06:48:25.917133Z","end":"2026-06-02T06:48:26.040845Z","steps":["trace[1284453718] 'agreement among raft nodes before linearized reading' (duration: 123.540058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:26.041117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.616661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:48:26.041138Z","caller":"traceutil/trace.go:171","msg":"trace[1450233623] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:820; }","duration":"100.638571ms","start":"2026-06-02T06:48:25.940495Z","end":"2026-06-02T06:48:26.041133Z","steps":["trace[1450233623] 'agreement among raft nodes before linearized reading' (duration: 100.60736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:26.04125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.953047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:48:26.041325Z","caller":"traceutil/trace.go:171","msg":"trace[1648602553] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:820; }","duration":"101.089981ms","start":"2026-06-02T06:48:25.940227Z","end":"2026-06-02T06:48:26.041317Z","steps":["trace[1648602553] 'agreement among raft nodes before linearized reading' (duration: 100.994679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:26.041259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.670232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:48:26.041544Z","caller":"traceutil/trace.go:171","msg":"trace[1605625227] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:820; }","duration":"100.966528ms","start":"2026-06-02T06:48:25.940569Z","end":"2026-06-02T06:48:26.041536Z","steps":["trace[1605625227] 'agreement among raft nodes before linearized reading' (duration: 100.676492ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:26.040819Z","caller":"traceutil/trace.go:171","msg":"trace[1777198256] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"144.30332ms","start":"2026-06-02T06:48:25.896509Z","end":"2026-06-02T06:48:26.040813Z","steps":["trace[1777198256] 'process raft request' (duration: 131.916652ms)","trace[1777198256] 'compare' (duration: 11.900777ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:38.908707Z","caller":"traceutil/trace.go:171","msg":"trace[1406785899] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"168.797245ms","start":"2026-06-02T06:48:38.739874Z","end":"2026-06-02T06:48:38.908671Z","steps":["trace[1406785899] 'process raft request' (duration: 168.570301ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:51.535753Z","caller":"traceutil/trace.go:171","msg":"trace[1512291734] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"121.211301ms","start":"2026-06-02T06:48:51.414513Z","end":"2026-06-02T06:48:51.535724Z","steps":["trace[1512291734] 'process raft request' (duration: 119.997308ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:51.536463Z","caller":"traceutil/trace.go:171","msg":"trace[1408944631] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"120.714521ms","start":"2026-06-02T06:48:51.415729Z","end":"2026-06-02T06:48:51.536443Z","steps":["trace[1408944631] 'process raft request' (duration: 119.888807ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:14.730891Z","caller":"traceutil/trace.go:171","msg":"trace[1811962660] linearizableReadLoop","detail":"{readStateIndex:1417; appliedIndex:1416; }","duration":"228.04759ms","start":"2026-06-02T06:49:14.50281Z","end":"2026-06-02T06:49:14.730858Z","steps":["trace[1811962660] 'read index received' (duration: 227.725504ms)","trace[1811962660] 'applied index is now lower than readState.Index' (duration: 320.596µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:49:14.731056Z","caller":"traceutil/trace.go:171","msg":"trace[212092205] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"264.681226ms","start":"2026-06-02T06:49:14.466316Z","end":"2026-06-02T06:49:14.730997Z","steps":["trace[212092205] 'process raft request' (duration: 264.35112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:14.731255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.393109ms","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-06-02T06:49:14.731917Z","caller":"traceutil/trace.go:171","msg":"trace[838681410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1369; }","duration":"108.06523ms","start":"2026-06-02T06:49:14.623819Z","end":"2026-06-02T06:49:14.731884Z","steps":["trace[838681410] 'agreement among raft nodes before linearized reading' (duration: 107.322898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:14.731314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.454366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-42hv7\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-06-02T06:49:14.732016Z","caller":"traceutil/trace.go:171","msg":"trace[254425543] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-42hv7; range_end:; response_count:1; response_revision:1369; }","duration":"229.199517ms","start":"2026-06-02T06:49:14.502788Z","end":"2026-06-02T06:49:14.731988Z","steps":["trace[254425543] 'agreement among raft nodes before linearized reading' (duration: 228.306053ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:22.201303Z","caller":"traceutil/trace.go:171","msg":"trace[59323007] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1497; }","duration":"102.163855ms","start":"2026-06-02T06:49:22.099112Z","end":"2026-06-02T06:49:22.201275Z","steps":["trace[59323007] 'process raft request' (duration: 101.924021ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:41.117656Z","caller":"traceutil/trace.go:171","msg":"trace[684031776] transaction","detail":"{read_only:false; response_revision:1794; number_of_response:1; }","duration":"220.370715ms","start":"2026-06-02T06:49:40.897255Z","end":"2026-06-02T06:49:41.117625Z","steps":["trace[684031776] 'process raft request' (duration: 220.174422ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:41.131192Z","caller":"traceutil/trace.go:171","msg":"trace[578557318] linearizableReadLoop","detail":"{readStateIndex:1871; appliedIndex:1869; }","duration":"175.511211ms","start":"2026-06-02T06:49:40.955648Z","end":"2026-06-02T06:49:41.13116Z","steps":["trace[578557318] 'read index received' (duration: 161.751734ms)","trace[578557318] 'applied index is now lower than readState.Index' (duration: 13.758287ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:49:41.131463Z","caller":"traceutil/trace.go:171","msg":"trace[760591598] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"197.04883ms","start":"2026-06-02T06:49:40.934394Z","end":"2026-06-02T06:49:41.131443Z","steps":["trace[760591598] 'process raft request' (duration: 196.614594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:41.131853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.189481ms","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-06-02T06:49:41.131905Z","caller":"traceutil/trace.go:171","msg":"trace[362684565] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1795; }","duration":"176.310002ms","start":"2026-06-02T06:49:40.955583Z","end":"2026-06-02T06:49:41.131893Z","steps":["trace[362684565] 'agreement among raft nodes before linearized reading' (duration: 176.117869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:41.132055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.875197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.161\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-02T06:49:41.132084Z","caller":"traceutil/trace.go:171","msg":"trace[1105107098] range","detail":"{range_begin:/registry/masterleases/199.19.213.161; range_end:; response_count:1; response_revision:1795; }","duration":"157.932618ms","start":"2026-06-02T06:49:40.97414Z","end":"2026-06-02T06:49:41.132072Z","steps":["trace[1105107098] 'agreement among raft nodes before linearized reading' (duration: 157.850577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:41.132205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.147492ms","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-06-02T06:49:41.132327Z","caller":"traceutil/trace.go:171","msg":"trace[1115607425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1795; }","duration":"172.309724ms","start":"2026-06-02T06:49:40.959995Z","end":"2026-06-02T06:49:41.132305Z","steps":["trace[1115607425] 'agreement among raft nodes before linearized reading' (duration: 171.999899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.15019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.219776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:49:49.150361Z","caller":"traceutil/trace.go:171","msg":"trace[2132579352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1900; }","duration":"172.46445ms","start":"2026-06-02T06:49:48.977869Z","end":"2026-06-02T06:49:49.150333Z","steps":["trace[2132579352] 'range keys from in-memory index tree' (duration: 172.134784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.150476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.845803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-02T06:49:49.15059Z","caller":"traceutil/trace.go:171","msg":"trace[497345342] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1900; }","duration":"123.967624ms","start":"2026-06-02T06:49:49.02658Z","end":"2026-06-02T06:49:49.150548Z","steps":["trace[497345342] 'range keys from in-memory index tree' (duration: 123.63844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.150744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.707411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:49:49.150899Z","caller":"traceutil/trace.go:171","msg":"trace[1012021330] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1900; }","duration":"136.905614ms","start":"2026-06-02T06:49:49.01396Z","end":"2026-06-02T06:49:49.150866Z","steps":["trace[1012021330] 'count revisions from in-memory index tree' (duration: 136.241284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.150966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.367052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b605f4fa-c17f-41b0-8555-85fed47d7d37\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-02T06:49:49.151033Z","caller":"traceutil/trace.go:171","msg":"trace[1516089424] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b605f4fa-c17f-41b0-8555-85fed47d7d37; range_end:; response_count:1; response_revision:1900; }","duration":"446.476905ms","start":"2026-06-02T06:49:48.704537Z","end":"2026-06-02T06:49:49.151014Z","steps":["trace[1516089424] 'range keys from in-memory index tree' (duration: 446.22363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.151075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:48.704511Z","time spent":"446.555505ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b605f4fa-c17f-41b0-8555-85fed47d7d37\" "} {"level":"info","ts":"2026-06-02T06:49:49.416873Z","caller":"traceutil/trace.go:171","msg":"trace[1420439815] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"258.251642ms","start":"2026-06-02T06:49:49.15856Z","end":"2026-06-02T06:49:49.416812Z","steps":["trace[1420439815] 'process raft request' (duration: 257.938518ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:49.578918Z","caller":"traceutil/trace.go:171","msg":"trace[874650444] linearizableReadLoop","detail":"{readStateIndex:1981; appliedIndex:1978; }","duration":"417.347476ms","start":"2026-06-02T06:49:49.161519Z","end":"2026-06-02T06:49:49.578866Z","steps":["trace[874650444] 'read index received' (duration: 254.935216ms)","trace[874650444] 'applied index is now lower than readState.Index' (duration: 162.41053ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:49:49.579021Z","caller":"traceutil/trace.go:171","msg":"trace[1335951745] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"419.338622ms","start":"2026-06-02T06:49:49.159626Z","end":"2026-06-02T06:49:49.578965Z","steps":["trace[1335951745] 'process raft request' (duration: 386.003808ms)","trace[1335951745] 'compare' (duration: 32.914718ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:49:49.579151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.588939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b605f4fa-c17f-41b0-8555-85fed47d7d37\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-06-02T06:49:49.57922Z","caller":"traceutil/trace.go:171","msg":"trace[387322061] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b605f4fa-c17f-41b0-8555-85fed47d7d37; range_end:; response_count:1; response_revision:1903; }","duration":"417.70044ms","start":"2026-06-02T06:49:49.161503Z","end":"2026-06-02T06:49:49.579203Z","steps":["trace[387322061] 'agreement among raft nodes before linearized reading' (duration: 417.559479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.579274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:49.161495Z","time spent":"417.764341ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3770,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b605f4fa-c17f-41b0-8555-85fed47d7d37\" "} {"level":"info","ts":"2026-06-02T06:49:49.57929Z","caller":"traceutil/trace.go:171","msg":"trace[1000449116] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"418.673544ms","start":"2026-06-02T06:49:49.160324Z","end":"2026-06-02T06:49:49.578997Z","steps":["trace[1000449116] 'process raft request' (duration: 418.446201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.579593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:49.160314Z","time spent":"419.18289ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:49:49.579562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:49.159608Z","time spent":"419.643487ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:49:49.589159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.461487ms","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-06-02T06:49:49.589246Z","caller":"traceutil/trace.go:171","msg":"trace[2025775307] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1904; }","duration":"412.568879ms","start":"2026-06-02T06:49:49.176663Z","end":"2026-06-02T06:49:49.589232Z","steps":["trace[2025775307] 'agreement among raft nodes before linearized reading' (duration: 412.364426ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.589289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:49.176649Z","time spent":"412.63264ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T06:49:49.589582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.797892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-02T06:49:49.58965Z","caller":"traceutil/trace.go:171","msg":"trace[1413068615] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1904; }","duration":"146.899493ms","start":"2026-06-02T06:49:49.442739Z","end":"2026-06-02T06:49:49.589639Z","steps":["trace[1413068615] 'agreement among raft nodes before linearized reading' (duration: 146.783511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.589295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.08963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:49:49.58989Z","caller":"traceutil/trace.go:171","msg":"trace[1749397977] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1904; }","duration":"120.74439ms","start":"2026-06-02T06:49:49.469127Z","end":"2026-06-02T06:49:49.589871Z","steps":["trace[1749397977] 'agreement among raft nodes before linearized reading' (duration: 120.086111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.589711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.242247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T06:49:49.589994Z","caller":"traceutil/trace.go:171","msg":"trace[1415812147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1904; }","duration":"103.54826ms","start":"2026-06-02T06:49:49.486429Z","end":"2026-06-02T06:49:49.589978Z","steps":["trace[1415812147] 'agreement among raft nodes before linearized reading' (duration: 103.227766ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.59004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.018361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:49:49.590812Z","caller":"traceutil/trace.go:171","msg":"trace[1729379428] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1904; }","duration":"233.912213ms","start":"2026-06-02T06:49:49.356854Z","end":"2026-06-02T06:49:49.590767Z","steps":["trace[1729379428] 'agreement among raft nodes before linearized reading' (duration: 233.040921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.590101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.915296ms","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-06-02T06:49:49.590885Z","caller":"traceutil/trace.go:171","msg":"trace[1904602801] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1904; }","duration":"411.743267ms","start":"2026-06-02T06:49:49.179123Z","end":"2026-06-02T06:49:49.590866Z","steps":["trace[1904602801] 'agreement among raft nodes before linearized reading' (duration: 410.792084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.591049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:49.179111Z","time spent":"411.84297ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T06:49:49.998971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.275831ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:49:49.999329Z","caller":"traceutil/trace.go:171","msg":"trace[1254767101] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"404.427265ms","start":"2026-06-02T06:49:49.594878Z","end":"2026-06-02T06:49:49.999305Z","steps":["trace[1254767101] 'process raft request' (duration: 404.308124ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:49.999316Z","caller":"traceutil/trace.go:171","msg":"trace[590985825] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"404.655318ms","start":"2026-06-02T06:49:49.594578Z","end":"2026-06-02T06:49:49.999233Z","steps":["trace[590985825] 'process raft request' (duration: 300.007763ms)","trace[590985825] 'compare' (duration: 101.816866ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:49:49.999425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:49.594863Z","time spent":"404.526577ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:49:49.999516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:49.594556Z","time spent":"404.852632ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:49:49.999522Z","caller":"traceutil/trace.go:171","msg":"trace[2049105361] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"404.621318ms","start":"2026-06-02T06:49:49.594873Z","end":"2026-06-02T06:49:49.999494Z","steps":["trace[2049105361] 'process raft request' (duration: 404.256623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.999633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:49.594865Z","time spent":"404.71135ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:49:49.999626Z","caller":"traceutil/trace.go:171","msg":"trace[1299347484] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"404.565957ms","start":"2026-06-02T06:49:49.59502Z","end":"2026-06-02T06:49:49.999586Z","steps":["trace[1299347484] 'process raft request' (duration: 404.227382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:49.999801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:49.595006Z","time spent":"404.699ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:49:50.56513Z","caller":"traceutil/trace.go:171","msg":"trace[1438900881] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"470.755548ms","start":"2026-06-02T06:49:50.094337Z","end":"2026-06-02T06:49:50.565093Z","steps":["trace[1438900881] 'process raft request' (duration: 376.836586ms)","trace[1438900881] 'compare' (duration: 86.476859ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:49:50.557983Z","caller":"traceutil/trace.go:171","msg":"trace[1716310940] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"207.014631ms","start":"2026-06-02T06:49:50.350918Z","end":"2026-06-02T06:49:50.557932Z","steps":["trace[1716310940] 'process raft request' (duration: 206.95066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:50.565351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:50.094297Z","time spent":"470.93839ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:49:50.565415Z","caller":"traceutil/trace.go:171","msg":"trace[1036638739] linearizableReadLoop","detail":"{readStateIndex:1988; appliedIndex:1987; }","duration":"455.509765ms","start":"2026-06-02T06:49:50.109865Z","end":"2026-06-02T06:49:50.565375Z","steps":["trace[1036638739] 'read index received' (duration: 361.31157ms)","trace[1036638739] 'applied index is now lower than readState.Index' (duration: 94.192515ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:49:50.565604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.729078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-02T06:49:50.56564Z","caller":"traceutil/trace.go:171","msg":"trace[1221703589] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1911; }","duration":"455.8305ms","start":"2026-06-02T06:49:50.109795Z","end":"2026-06-02T06:49:50.565626Z","steps":["trace[1221703589] 'agreement among raft nodes before linearized reading' (duration: 455.689528ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:50.565663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:50.109769Z","time spent":"455.88812ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":580,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-02T06:49:50.565761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.360596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-02T06:49:50.565808Z","caller":"traceutil/trace.go:171","msg":"trace[2039002430] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1911; }","duration":"406.434207ms","start":"2026-06-02T06:49:50.159356Z","end":"2026-06-02T06:49:50.56579Z","steps":["trace[2039002430] 'agreement among raft nodes before linearized reading' (duration: 406.202923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:49:50.565851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:49:50.159307Z","time spent":"406.530618ms","remote":"127.0.0.1:58014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-02T06:50:06.286797Z","caller":"traceutil/trace.go:171","msg":"trace[682654597] linearizableReadLoop","detail":"{readStateIndex:2125; appliedIndex:2124; }","duration":"208.817584ms","start":"2026-06-02T06:50:06.077945Z","end":"2026-06-02T06:50:06.286763Z","steps":["trace[682654597] 'read index received' (duration: 208.643792ms)","trace[682654597] 'applied index is now lower than readState.Index' (duration: 171.862µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:50:06.286955Z","caller":"traceutil/trace.go:171","msg":"trace[1244928998] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"229.841115ms","start":"2026-06-02T06:50:06.057045Z","end":"2026-06-02T06:50:06.286886Z","steps":["trace[1244928998] 'process raft request' (duration: 229.473539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:06.287146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.175681ms","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-06-02T06:50:06.287205Z","caller":"traceutil/trace.go:171","msg":"trace[326455047] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2044; }","duration":"209.321322ms","start":"2026-06-02T06:50:06.077867Z","end":"2026-06-02T06:50:06.287189Z","steps":["trace[326455047] 'agreement among raft nodes before linearized reading' (duration: 209.110129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:06.291775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.234239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-02T06:50:06.29183Z","caller":"traceutil/trace.go:171","msg":"trace[496190986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2044; }","duration":"193.34396ms","start":"2026-06-02T06:50:06.098473Z","end":"2026-06-02T06:50:06.291817Z","steps":["trace[496190986] 'agreement among raft nodes before linearized reading' (duration: 193.219449ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:06.292065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.279545ms","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-06-02T06:50:06.292104Z","caller":"traceutil/trace.go:171","msg":"trace[74796721] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2044; }","duration":"155.358907ms","start":"2026-06-02T06:50:06.136736Z","end":"2026-06-02T06:50:06.292095Z","steps":["trace[74796721] 'agreement among raft nodes before linearized reading' (duration: 155.262396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:06.292319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.971709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-02T06:50:06.292391Z","caller":"traceutil/trace.go:171","msg":"trace[1300246366] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2044; }","duration":"160.0669ms","start":"2026-06-02T06:50:06.132314Z","end":"2026-06-02T06:50:06.292381Z","steps":["trace[1300246366] 'agreement among raft nodes before linearized reading' (duration: 159.899557ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:18.841539Z","caller":"traceutil/trace.go:171","msg":"trace[294710930] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"161.166304ms","start":"2026-06-02T06:50:18.680342Z","end":"2026-06-02T06:50:18.841508Z","steps":["trace[294710930] 'process raft request' (duration: 160.938361ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:24.550591Z","caller":"traceutil/trace.go:171","msg":"trace[2210447] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"140.555516ms","start":"2026-06-02T06:50:24.410005Z","end":"2026-06-02T06:50:24.55056Z","steps":["trace[2210447] 'process raft request' (duration: 140.366564ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:24.725538Z","caller":"traceutil/trace.go:171","msg":"trace[1529387350] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"314.397355ms","start":"2026-06-02T06:50:24.411099Z","end":"2026-06-02T06:50:24.725496Z","steps":["trace[1529387350] 'process raft request' (duration: 240.991372ms)","trace[1529387350] 'compare' (duration: 73.126609ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:50:24.725769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:24.411091Z","time spent":"314.556617ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:50:24.725995Z","caller":"traceutil/trace.go:171","msg":"trace[2043200020] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"283.388251ms","start":"2026-06-02T06:50:24.442539Z","end":"2026-06-02T06:50:24.725927Z","steps":["trace[2043200020] 'process raft request' (duration: 282.902105ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:24.72612Z","caller":"traceutil/trace.go:171","msg":"trace[609567937] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"194.094217ms","start":"2026-06-02T06:50:24.531988Z","end":"2026-06-02T06:50:24.726082Z","steps":["trace[609567937] 'process raft request' (duration: 193.766563ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:25.844284Z","caller":"traceutil/trace.go:171","msg":"trace[1236910771] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"225.001703ms","start":"2026-06-02T06:50:25.619207Z","end":"2026-06-02T06:50:25.844208Z","steps":["trace[1236910771] 'process raft request' (duration: 224.80228ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:26.230831Z","caller":"traceutil/trace.go:171","msg":"trace[678905075] linearizableReadLoop","detail":"{readStateIndex:2241; appliedIndex:2239; }","duration":"400.407332ms","start":"2026-06-02T06:50:25.830385Z","end":"2026-06-02T06:50:26.230792Z","steps":["trace[678905075] 'read index received' (duration: 13.608913ms)","trace[678905075] 'applied index is now lower than readState.Index' (duration: 386.796699ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:50:26.231053Z","caller":"traceutil/trace.go:171","msg":"trace[198380710] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"495.529708ms","start":"2026-06-02T06:50:25.735429Z","end":"2026-06-02T06:50:26.230959Z","steps":["trace[198380710] 'process raft request' (duration: 495.165894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:26.231378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:25.735397Z","time spent":"495.844392ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:50:26.231613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.205392ms","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-06-02T06:50:26.231674Z","caller":"traceutil/trace.go:171","msg":"trace[2034920695] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2156; }","duration":"401.347804ms","start":"2026-06-02T06:50:25.830311Z","end":"2026-06-02T06:50:26.231658Z","steps":["trace[2034920695] 'agreement among raft nodes before linearized reading' (duration: 401.04623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:26.231856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:25.83027Z","time spent":"401.569456ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T06:50:26.895337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.083843ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-02T06:50:26.895559Z","caller":"traceutil/trace.go:171","msg":"trace[2139380679] linearizableReadLoop","detail":"{readStateIndex:2242; appliedIndex:2241; }","duration":"664.611541ms","start":"2026-06-02T06:50:26.230928Z","end":"2026-06-02T06:50:26.89554Z","steps":["trace[2139380679] 'read index received' (duration: 249.399007ms)","trace[2139380679] 'applied index is now lower than readState.Index' (duration: 415.211214ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:50:26.895674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.074845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T06:50:26.895736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00092982s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-02T06:50:26.895755Z","caller":"traceutil/trace.go:171","msg":"trace[39786115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2156; }","duration":"916.214187ms","start":"2026-06-02T06:50:25.979516Z","end":"2026-06-02T06:50:26.895731Z","steps":["trace[39786115] 'agreement among raft nodes before linearized reading' (duration: 916.091365ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:26.895784Z","caller":"traceutil/trace.go:171","msg":"trace[598505984] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2156; }","duration":"1.001026621s","start":"2026-06-02T06:50:25.894747Z","end":"2026-06-02T06:50:26.895773Z","steps":["trace[598505984] 'agreement among raft nodes before linearized reading' (duration: 1.000869749s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:26.895815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:25.894722Z","time spent":"1.001084982s","remote":"127.0.0.1:58014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-02T06:50:26.895808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:25.97949Z","time spent":"916.305417ms","remote":"127.0.0.1:49392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-02T06:50:26.896098Z","caller":"traceutil/trace.go:171","msg":"trace[776980461] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"658.400373ms","start":"2026-06-02T06:50:26.237578Z","end":"2026-06-02T06:50:26.895979Z","steps":["trace[776980461] 'process raft request' (duration: 657.867636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:26.896422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.237546Z","time spent":"658.662196ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:50:27.199303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.362585284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-02T06:50:27.200029Z","caller":"traceutil/trace.go:171","msg":"trace[507488005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2157; }","duration":"1.363338863s","start":"2026-06-02T06:50:25.836656Z","end":"2026-06-02T06:50:27.199995Z","steps":["trace[507488005] 'agreement among raft nodes before linearized reading' (duration: 1.059097098s)","trace[507488005] 'range keys from in-memory index tree' (duration: 303.386035ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:50:27.20015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:25.836641Z","time spent":"1.363488296s","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T06:50:27.19991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.490969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:50:27.200379Z","caller":"traceutil/trace.go:171","msg":"trace[2097696203] linearizableReadLoop","detail":"{readStateIndex:2244; appliedIndex:2243; }","duration":"304.761502ms","start":"2026-06-02T06:50:26.895596Z","end":"2026-06-02T06:50:27.200358Z","steps":["trace[2097696203] 'read index received' (duration: 74.565254ms)","trace[2097696203] 'applied index is now lower than readState.Index' (duration: 230.193928ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:50:27.200517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.071241ms","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-06-02T06:50:27.200583Z","caller":"traceutil/trace.go:171","msg":"trace[872942257] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2158; }","duration":"469.145211ms","start":"2026-06-02T06:50:26.731418Z","end":"2026-06-02T06:50:27.200563Z","steps":["trace[872942257] 'agreement among raft nodes before linearized reading' (duration: 468.962999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.20063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.731412Z","time spent":"469.209172ms","remote":"127.0.0.1:49648","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-06-02T06:50:27.200646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.569308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T06:50:27.200633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.394791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b530ecd64dd754\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-02T06:50:27.200688Z","caller":"traceutil/trace.go:171","msg":"trace[1010877817] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2158; }","duration":"710.68789ms","start":"2026-06-02T06:50:26.489984Z","end":"2026-06-02T06:50:27.200672Z","steps":["trace[1010877817] 'agreement among raft nodes before linearized reading' (duration: 710.578278ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:27.200739Z","caller":"traceutil/trace.go:171","msg":"trace[1505713804] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b530ecd64dd754; range_end:; response_count:1; response_revision:2158; }","duration":"637.572683ms","start":"2026-06-02T06:50:26.563136Z","end":"2026-06-02T06:50:27.200709Z","steps":["trace[1505713804] 'agreement among raft nodes before linearized reading' (duration: 637.255139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.200741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.485633ms","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-06-02T06:50:27.200834Z","caller":"traceutil/trace.go:171","msg":"trace[1986599127] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"323.419197ms","start":"2026-06-02T06:50:26.877397Z","end":"2026-06-02T06:50:27.200817Z","steps":["trace[1986599127] 'process raft request' (duration: 92.876635ms)","trace[1986599127] 'compare' (duration: 229.145715ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:50:27.200889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.987963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-02T06:50:27.200903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.877369Z","time spent":"323.497948ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:50:27.200939Z","caller":"traceutil/trace.go:171","msg":"trace[789311055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2158; }","duration":"470.033494ms","start":"2026-06-02T06:50:26.730895Z","end":"2026-06-02T06:50:27.200928Z","steps":["trace[789311055] 'agreement among raft nodes before linearized reading' (duration: 469.917462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.200945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.563701ms","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-06-02T06:50:27.200968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.73083Z","time spent":"470.131834ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-02T06:50:27.200984Z","caller":"traceutil/trace.go:171","msg":"trace[745813016] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2158; }","duration":"873.678062ms","start":"2026-06-02T06:50:26.327296Z","end":"2026-06-02T06:50:27.200974Z","steps":["trace[745813016] 'agreement among raft nodes before linearized reading' (duration: 873.531061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.201048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.327269Z","time spent":"873.761963ms","remote":"127.0.0.1:33070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:50:27.201152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.420075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-06-02T06:50:27.201301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.081463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-06-02T06:50:27.201349Z","caller":"traceutil/trace.go:171","msg":"trace[1213585886] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2158; }","duration":"462.152064ms","start":"2026-06-02T06:50:26.739186Z","end":"2026-06-02T06:50:27.201338Z","steps":["trace[1213585886] 'agreement among raft nodes before linearized reading' (duration: 462.032012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.201381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.739179Z","time spent":"462.192584ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12406,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-02T06:50:27.201257Z","caller":"traceutil/trace.go:171","msg":"trace[439403876] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2158; }","duration":"469.537597ms","start":"2026-06-02T06:50:26.731703Z","end":"2026-06-02T06:50:27.20124Z","steps":["trace[439403876] 'agreement among raft nodes before linearized reading' (duration: 469.222203ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:27.200885Z","caller":"traceutil/trace.go:171","msg":"trace[1348605307] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2158; }","duration":"645.692996ms","start":"2026-06-02T06:50:26.555141Z","end":"2026-06-02T06:50:27.200834Z","steps":["trace[1348605307] 'agreement among raft nodes before linearized reading' (duration: 645.26535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.201927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.731698Z","time spent":"469.855451ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-02T06:50:27.201998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.555116Z","time spent":"646.863782ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T06:50:27.200796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.489954Z","time spent":"710.792361ms","remote":"127.0.0.1:33094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:50:27.200789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.563111Z","time spent":"637.668504ms","remote":"127.0.0.1:49456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b530ecd64dd754\" "} {"level":"warn","ts":"2026-06-02T06:50:27.542227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.626661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-06-02T06:50:27.542563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.145708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:50:27.542647Z","caller":"traceutil/trace.go:171","msg":"trace[1761993827] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"431.563541ms","start":"2026-06-02T06:50:27.111062Z","end":"2026-06-02T06:50:27.542625Z","steps":["trace[1761993827] 'process raft request' (duration: 273.252602ms)","trace[1761993827] 'compare' (duration: 157.175965ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:50:27.542671Z","caller":"traceutil/trace.go:171","msg":"trace[426798903] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2159; }","duration":"462.32179ms","start":"2026-06-02T06:50:27.080323Z","end":"2026-06-02T06:50:27.542645Z","steps":["trace[426798903] 'agreement among raft nodes before linearized reading' (duration: 462.137058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.542725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:27.080298Z","time spent":"462.414031ms","remote":"127.0.0.1:33138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:50:27.542914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.88905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T06:50:27.542963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:27.111044Z","time spent":"431.767523ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:50:27.543077Z","caller":"traceutil/trace.go:171","msg":"trace[399620844] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2159; }","duration":"646.145353ms","start":"2026-06-02T06:50:26.89691Z","end":"2026-06-02T06:50:27.543055Z","steps":["trace[399620844] 'agreement among raft nodes before linearized reading' (duration: 645.781769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.543191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:26.896895Z","time spent":"646.224924ms","remote":"127.0.0.1:49400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-02T06:50:27.542404Z","caller":"traceutil/trace.go:171","msg":"trace[289977447] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2244; }","duration":"341.847868ms","start":"2026-06-02T06:50:27.200534Z","end":"2026-06-02T06:50:27.542382Z","steps":["trace[289977447] 'read index received' (duration: 183.878733ms)","trace[289977447] 'applied index is now lower than readState.Index' (duration: 157.967525ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:50:27.550364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:27.205866Z","time spent":"344.493942ms","remote":"127.0.0.1:49456","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-02T06:50:27.55073Z","caller":"traceutil/trace.go:171","msg":"trace[1623203501] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"344.586342ms","start":"2026-06-02T06:50:27.206114Z","end":"2026-06-02T06:50:27.550701Z","steps":["trace[1623203501] 'process raft request' (duration: 344.470391ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:27.550906Z","caller":"traceutil/trace.go:171","msg":"trace[812092220] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"344.864786ms","start":"2026-06-02T06:50:27.205987Z","end":"2026-06-02T06:50:27.550852Z","steps":["trace[812092220] 'process raft request' (duration: 344.36182ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:27.551003Z","caller":"traceutil/trace.go:171","msg":"trace[1731144799] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"344.111347ms","start":"2026-06-02T06:50:27.206871Z","end":"2026-06-02T06:50:27.550982Z","steps":["trace[1731144799] 'process raft request' (duration: 343.760712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.55118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:27.206848Z","time spent":"344.261828ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:50:27.551252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:27.205965Z","time spent":"345.048518ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:50:27.551638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:27.206092Z","time spent":"344.854706ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:50:27.551672Z","caller":"traceutil/trace.go:171","msg":"trace[1122675629] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"344.182077ms","start":"2026-06-02T06:50:27.207481Z","end":"2026-06-02T06:50:27.551663Z","steps":["trace[1122675629] 'process raft request' (duration: 343.412907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.55193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:27.207468Z","time spent":"344.421281ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:50:27.552279Z","caller":"traceutil/trace.go:171","msg":"trace[50245347] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"344.220128ms","start":"2026-06-02T06:50:27.208046Z","end":"2026-06-02T06:50:27.552267Z","steps":["trace[50245347] 'process raft request' (duration: 343.583919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.552372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:27.208037Z","time spent":"344.277929ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:50:27.552688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.914961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:50:27.552794Z","caller":"traceutil/trace.go:171","msg":"trace[213948683] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2165; }","duration":"339.072193ms","start":"2026-06-02T06:50:27.213705Z","end":"2026-06-02T06:50:27.552777Z","steps":["trace[213948683] 'agreement among raft nodes before linearized reading' (duration: 338.593557ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:27.552778Z","caller":"traceutil/trace.go:171","msg":"trace[1633831419] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"258.532485ms","start":"2026-06-02T06:50:27.294227Z","end":"2026-06-02T06:50:27.55276Z","steps":["trace[1633831419] 'process raft request' (duration: 257.582093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:50:27.552907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:50:27.213697Z","time spent":"339.154453ms","remote":"127.0.0.1:49816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-02T06:50:27.5528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.45941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:50:27.553077Z","caller":"traceutil/trace.go:171","msg":"trace[1890362600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2165; }","duration":"123.781423ms","start":"2026-06-02T06:50:27.429285Z","end":"2026-06-02T06:50:27.553067Z","steps":["trace[1890362600] 'agreement among raft nodes before linearized reading' (duration: 123.481099ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:51:22.349118Z","caller":"traceutil/trace.go:171","msg":"trace[403560815] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"125.246539ms","start":"2026-06-02T06:51:22.223844Z","end":"2026-06-02T06:51:22.34909Z","steps":["trace[403560815] 'process raft request' (duration: 125.040706ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:51:34.276415Z","caller":"traceutil/trace.go:171","msg":"trace[387328617] transaction","detail":"{read_only:false; response_revision:2621; number_of_response:1; }","duration":"320.628039ms","start":"2026-06-02T06:51:33.955753Z","end":"2026-06-02T06:51:34.276381Z","steps":["trace[387328617] 'process raft request' (duration: 320.374559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:51:34.276668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:51:33.955739Z","time spent":"320.789025ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:51:34.278502Z","caller":"traceutil/trace.go:171","msg":"trace[937638202] linearizableReadLoop","detail":"{readStateIndex:2725; appliedIndex:2723; }","duration":"297.234524ms","start":"2026-06-02T06:51:33.981247Z","end":"2026-06-02T06:51:34.278481Z","steps":["trace[937638202] 'read index received' (duration: 295.198741ms)","trace[937638202] 'applied index is now lower than readState.Index' (duration: 2.034263ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:51:34.27858Z","caller":"traceutil/trace.go:171","msg":"trace[290086637] transaction","detail":"{read_only:false; response_revision:2623; number_of_response:1; }","duration":"320.015676ms","start":"2026-06-02T06:51:33.958531Z","end":"2026-06-02T06:51:34.278547Z","steps":["trace[290086637] 'process raft request' (duration: 319.795367ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:51:34.278635Z","caller":"traceutil/trace.go:171","msg":"trace[961750815] transaction","detail":"{read_only:false; response_revision:2624; number_of_response:1; }","duration":"216.227424ms","start":"2026-06-02T06:51:34.062393Z","end":"2026-06-02T06:51:34.27862Z","steps":["trace[961750815] 'process raft request' (duration: 215.988044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:51:34.278703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:51:33.958518Z","time spent":"320.12835ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:51:34.278942Z","caller":"traceutil/trace.go:171","msg":"trace[553012478] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"136.684068ms","start":"2026-06-02T06:51:34.142242Z","end":"2026-06-02T06:51:34.278926Z","steps":["trace[553012478] 'process raft request' (duration: 136.181978ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:51:34.279055Z","caller":"traceutil/trace.go:171","msg":"trace[743637888] transaction","detail":"{read_only:false; response_revision:2622; number_of_response:1; }","duration":"322.560187ms","start":"2026-06-02T06:51:33.956474Z","end":"2026-06-02T06:51:34.279035Z","steps":["trace[743637888] 'process raft request' (duration: 321.753264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:51:34.279183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:51:33.956442Z","time spent":"322.665891ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:51:34.279354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.195845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-02T06:51:34.279417Z","caller":"traceutil/trace.go:171","msg":"trace[1503754579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2625; }","duration":"270.30922ms","start":"2026-06-02T06:51:34.009093Z","end":"2026-06-02T06:51:34.279402Z","steps":["trace[1503754579] 'agreement among raft nodes before linearized reading' (duration: 270.148744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:51:34.279202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.953953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:51:34.27956Z","caller":"traceutil/trace.go:171","msg":"trace[113356708] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2625; }","duration":"298.362128ms","start":"2026-06-02T06:51:33.981185Z","end":"2026-06-02T06:51:34.279547Z","steps":["trace[113356708] 'agreement among raft nodes before linearized reading' (duration: 297.972523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:51:34.279641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.896843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T06:51:34.279726Z","caller":"traceutil/trace.go:171","msg":"trace[183846132] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2625; }","duration":"270.014188ms","start":"2026-06-02T06:51:34.009696Z","end":"2026-06-02T06:51:34.27971Z","steps":["trace[183846132] 'agreement among raft nodes before linearized reading' (duration: 269.81137ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:51:58.312389Z","caller":"traceutil/trace.go:171","msg":"trace[509943215] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"100.705493ms","start":"2026-06-02T06:51:58.211647Z","end":"2026-06-02T06:51:58.312352Z","steps":["trace[509943215] 'process raft request' (duration: 100.252347ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:51:58.59958Z","caller":"traceutil/trace.go:171","msg":"trace[1788032869] linearizableReadLoop","detail":"{readStateIndex:2866; appliedIndex:2865; }","duration":"140.159054ms","start":"2026-06-02T06:51:58.459384Z","end":"2026-06-02T06:51:58.599543Z","steps":["trace[1788032869] 'read index received' (duration: 71.066107ms)","trace[1788032869] 'applied index is now lower than readState.Index' (duration: 69.091887ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:51:58.599777Z","caller":"traceutil/trace.go:171","msg":"trace[1780567547] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"155.348305ms","start":"2026-06-02T06:51:58.444386Z","end":"2026-06-02T06:51:58.599734Z","steps":["trace[1780567547] 'process raft request' (duration: 86.047051ms)","trace[1780567547] 'compare' (duration: 68.990343ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:51:58.599974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.249352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-02T06:51:58.600065Z","caller":"traceutil/trace.go:171","msg":"trace[1086308690] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2759; }","duration":"144.372087ms","start":"2026-06-02T06:51:58.455675Z","end":"2026-06-02T06:51:58.600047Z","steps":["trace[1086308690] 'agreement among raft nodes before linearized reading' (duration: 144.110678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:51:58.600393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.493325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-02T06:51:58.600482Z","caller":"traceutil/trace.go:171","msg":"trace[919009217] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2759; }","duration":"151.677382ms","start":"2026-06-02T06:51:58.448782Z","end":"2026-06-02T06:51:58.600459Z","steps":["trace[919009217] 'agreement among raft nodes before linearized reading' (duration: 151.299888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:51:58.600842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.712933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-02T06:51:58.6009Z","caller":"traceutil/trace.go:171","msg":"trace[818232969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2759; }","duration":"159.792336ms","start":"2026-06-02T06:51:58.441092Z","end":"2026-06-02T06:51:58.600884Z","steps":["trace[818232969] 'agreement among raft nodes before linearized reading' (duration: 158.568732ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:51:58.645849Z","caller":"traceutil/trace.go:171","msg":"trace[838469215] transaction","detail":"{read_only:false; response_revision:2760; number_of_response:1; }","duration":"180.946873ms","start":"2026-06-02T06:51:58.46488Z","end":"2026-06-02T06:51:58.645827Z","steps":["trace[838469215] 'process raft request' (duration: 180.822929ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:52:04.035295Z","caller":"traceutil/trace.go:171","msg":"trace[101110633] linearizableReadLoop","detail":"{readStateIndex:2895; appliedIndex:2894; }","duration":"266.973653ms","start":"2026-06-02T06:52:03.768291Z","end":"2026-06-02T06:52:04.035265Z","steps":["trace[101110633] 'read index received' (duration: 266.719764ms)","trace[101110633] 'applied index is now lower than readState.Index' (duration: 252.879µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:52:04.035734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.411838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-02T06:52:04.03582Z","caller":"traceutil/trace.go:171","msg":"trace[1188542408] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2787; }","duration":"267.599605ms","start":"2026-06-02T06:52:03.768204Z","end":"2026-06-02T06:52:04.035804Z","steps":["trace[1188542408] 'agreement among raft nodes before linearized reading' (duration: 267.18568ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:52:04.035868Z","caller":"traceutil/trace.go:171","msg":"trace[599946632] transaction","detail":"{read_only:false; response_revision:2787; number_of_response:1; }","duration":"376.12222ms","start":"2026-06-02T06:52:03.659641Z","end":"2026-06-02T06:52:04.035763Z","steps":["trace[599946632] 'process raft request' (duration: 375.457176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:52:04.036286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:52:03.659619Z","time spent":"376.378149ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:52:09.993486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.71131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-02T06:52:09.993553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.184487ms","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-06-02T06:52:09.993622Z","caller":"traceutil/trace.go:171","msg":"trace[2129814535] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2818; }","duration":"584.945268ms","start":"2026-06-02T06:52:09.40865Z","end":"2026-06-02T06:52:09.993595Z","steps":["trace[2129814535] 'count revisions from in-memory index tree' (duration: 584.466352ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:52:09.993637Z","caller":"traceutil/trace.go:171","msg":"trace[1828259232] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2818; }","duration":"437.362382ms","start":"2026-06-02T06:52:09.556252Z","end":"2026-06-02T06:52:09.993615Z","steps":["trace[1828259232] 'range keys from in-memory index tree' (duration: 436.958899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:52:09.993673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:52:09.5562Z","time spent":"437.466146ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T06:52:09.993684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:52:09.408619Z","time spent":"585.049612ms","remote":"127.0.0.1:49560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-06-02T06:52:10.311909Z","caller":"traceutil/trace.go:171","msg":"trace[112981403] transaction","detail":"{read_only:false; response_revision:2819; number_of_response:1; }","duration":"312.44592ms","start":"2026-06-02T06:52:09.999426Z","end":"2026-06-02T06:52:10.311872Z","steps":["trace[112981403] 'process raft request' (duration: 312.19339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:52:10.312124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:52:09.999394Z","time spent":"312.619605ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:52:10.312744Z","caller":"traceutil/trace.go:171","msg":"trace[1486444737] transaction","detail":"{read_only:false; response_revision:2820; number_of_response:1; }","duration":"256.430437ms","start":"2026-06-02T06:52:10.056286Z","end":"2026-06-02T06:52:10.312716Z","steps":["trace[1486444737] 'process raft request' (duration: 256.297713ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:00.321737Z","caller":"traceutil/trace.go:171","msg":"trace[1916239992] transaction","detail":"{read_only:false; response_revision:4203; number_of_response:1; }","duration":"102.365698ms","start":"2026-06-02T06:56:00.219339Z","end":"2026-06-02T06:56:00.321705Z","steps":["trace[1916239992] 'process raft request' (duration: 43.284425ms)","trace[1916239992] 'compare' (duration: 58.722715ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:14.775125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.208247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-06-02T06:56:14.775235Z","caller":"traceutil/trace.go:171","msg":"trace[499075718] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4693; }","duration":"561.345369ms","start":"2026-06-02T06:56:14.213862Z","end":"2026-06-02T06:56:14.775208Z","steps":["trace[499075718] 'range keys from in-memory index tree' (duration: 561.060514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:14.775284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:14.213857Z","time spent":"561.41571ms","remote":"127.0.0.1:49480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":1,"response size":673,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" "} {"level":"warn","ts":"2026-06-02T06:56:14.775961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.740165ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:56:14.776029Z","caller":"traceutil/trace.go:171","msg":"trace[47526278] linearizableReadLoop","detail":"{readStateIndex:4877; appliedIndex:4876; }","duration":"548.792212ms","start":"2026-06-02T06:56:14.227224Z","end":"2026-06-02T06:56:14.776017Z","steps":["trace[47526278] 'read index received' (duration: 168.843334ms)","trace[47526278] 'applied index is now lower than readState.Index' (duration: 379.947658ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:14.776159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.934745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:56:14.776112Z","caller":"traceutil/trace.go:171","msg":"trace[920841337] transaction","detail":"{read_only:false; response_revision:4694; number_of_response:1; }","duration":"549.065877ms","start":"2026-06-02T06:56:14.226978Z","end":"2026-06-02T06:56:14.776044Z","steps":["trace[920841337] 'process raft request' (duration: 169.16226ms)","trace[920841337] 'compare' (duration: 379.538261ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:14.776194Z","caller":"traceutil/trace.go:171","msg":"trace[1965153613] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4694; }","duration":"549.012226ms","start":"2026-06-02T06:56:14.227171Z","end":"2026-06-02T06:56:14.776183Z","steps":["trace[1965153613] 'agreement among raft nodes before linearized reading' (duration: 548.949035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:14.776259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:14.227145Z","time spent":"549.074377ms","remote":"127.0.0.1:49816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-02T06:56:14.776378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:14.226966Z","time spent":"549.25682ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:14.776621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.765195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-02T06:56:14.776655Z","caller":"traceutil/trace.go:171","msg":"trace[353494231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4694; }","duration":"230.850367ms","start":"2026-06-02T06:56:14.545794Z","end":"2026-06-02T06:56:14.776644Z","steps":["trace[353494231] 'agreement among raft nodes before linearized reading' (duration: 230.739915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:14.77681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.584254ms","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-06-02T06:56:14.776841Z","caller":"traceutil/trace.go:171","msg":"trace[1231646725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4694; }","duration":"170.657415ms","start":"2026-06-02T06:56:14.606175Z","end":"2026-06-02T06:56:14.776832Z","steps":["trace[1231646725] 'agreement among raft nodes before linearized reading' (duration: 170.557753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:14.777047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.085422ms","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-06-02T06:56:14.777039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.966291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-02T06:56:14.777076Z","caller":"traceutil/trace.go:171","msg":"trace[955025477] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4694; }","duration":"231.158412ms","start":"2026-06-02T06:56:14.545908Z","end":"2026-06-02T06:56:14.777067Z","steps":["trace[955025477] 'agreement among raft nodes before linearized reading' (duration: 231.077041ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:14.777103Z","caller":"traceutil/trace.go:171","msg":"trace[537609959] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4694; }","duration":"234.067593ms","start":"2026-06-02T06:56:14.543013Z","end":"2026-06-02T06:56:14.77708Z","steps":["trace[537609959] 'agreement among raft nodes before linearized reading' (duration: 233.903191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:14.777373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.028005ms","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-06-02T06:56:14.777418Z","caller":"traceutil/trace.go:171","msg":"trace[1473721217] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:4694; }","duration":"408.109267ms","start":"2026-06-02T06:56:14.369295Z","end":"2026-06-02T06:56:14.777404Z","steps":["trace[1473721217] 'agreement among raft nodes before linearized reading' (duration: 408.034106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:14.777433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.932705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:46 size:1954238"} {"level":"warn","ts":"2026-06-02T06:56:14.777459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:14.369277Z","time spent":"408.169428ms","remote":"127.0.0.1:49546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-06-02T06:56:14.777499Z","caller":"traceutil/trace.go:171","msg":"trace[763106964] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:46; response_revision:4694; }","duration":"534.028277ms","start":"2026-06-02T06:56:14.243448Z","end":"2026-06-02T06:56:14.777477Z","steps":["trace[763106964] 'agreement among raft nodes before linearized reading' (duration: 532.904017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:14.777549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:14.243425Z","time spent":"534.110138ms","remote":"127.0.0.1:49486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":46,"response size":1954261,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-06-02T06:56:14.912812Z","caller":"traceutil/trace.go:171","msg":"trace[196408867] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"129.821548ms","start":"2026-06-02T06:56:14.782954Z","end":"2026-06-02T06:56:14.912776Z","steps":["trace[196408867] 'process raft request' (duration: 105.509027ms)","trace[196408867] 'compare' (duration: 24.125087ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:14.913109Z","caller":"traceutil/trace.go:171","msg":"trace[1495006454] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"130.080812ms","start":"2026-06-02T06:56:14.783018Z","end":"2026-06-02T06:56:14.913099Z","steps":["trace[1495006454] 'process raft request' (duration: 129.706826ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:14.913535Z","caller":"traceutil/trace.go:171","msg":"trace[730682956] transaction","detail":"{read_only:false; response_revision:4698; number_of_response:1; }","duration":"129.701345ms","start":"2026-06-02T06:56:14.783823Z","end":"2026-06-02T06:56:14.913524Z","steps":["trace[730682956] 'process raft request' (duration: 129.233867ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:14.91377Z","caller":"traceutil/trace.go:171","msg":"trace[1630128686] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"108.429568ms","start":"2026-06-02T06:56:14.805296Z","end":"2026-06-02T06:56:14.913726Z","steps":["trace[1630128686] 'process raft request' (duration: 108.05314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:14.913881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.137559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-06-02T06:56:14.914002Z","caller":"traceutil/trace.go:171","msg":"trace[1178515261] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4699; }","duration":"128.316142ms","start":"2026-06-02T06:56:14.785659Z","end":"2026-06-02T06:56:14.913975Z","steps":["trace[1178515261] 'agreement among raft nodes before linearized reading' (duration: 127.951095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:16.218633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.553705ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:56:16.218762Z","caller":"traceutil/trace.go:171","msg":"trace[2005827588] linearizableReadLoop","detail":"{readStateIndex:4912; appliedIndex:4911; }","duration":"598.066975ms","start":"2026-06-02T06:56:15.620662Z","end":"2026-06-02T06:56:16.218729Z","steps":["trace[2005827588] 'read index received' (duration: 232.231105ms)","trace[2005827588] 'applied index is now lower than readState.Index' (duration: 365.83394ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:16.218776Z","caller":"traceutil/trace.go:171","msg":"trace[670585218] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"607.827585ms","start":"2026-06-02T06:56:15.610904Z","end":"2026-06-02T06:56:16.218732Z","steps":["trace[670585218] 'process raft request' (duration: 242.062877ms)","trace[670585218] 'compare' (duration: 365.234299ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:16.218965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:15.610881Z","time spent":"607.986038ms","remote":"127.0.0.1:58562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2229,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:56:16.219019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.347401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-06-02T06:56:16.219058Z","caller":"traceutil/trace.go:171","msg":"trace[697391835] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4729; }","duration":"598.418082ms","start":"2026-06-02T06:56:15.62063Z","end":"2026-06-02T06:56:16.219048Z","steps":["trace[697391835] 'agreement among raft nodes before linearized reading' (duration: 598.197448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:16.219102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:15.620619Z","time spent":"598.472563ms","remote":"127.0.0.1:49748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1147,"request content":"key:\"/registry/storageclasses/general\" "} {"level":"warn","ts":"2026-06-02T06:56:16.744966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.718168ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:56:16.7457Z","caller":"traceutil/trace.go:171","msg":"trace[128952514] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"1.120492698s","start":"2026-06-02T06:56:15.625143Z","end":"2026-06-02T06:56:16.745636Z","steps":["trace[128952514] 'process raft request' (duration: 845.968638ms)","trace[128952514] 'compare' (duration: 273.531974ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:16.74601Z","caller":"traceutil/trace.go:171","msg":"trace[697214218] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"1.113531548s","start":"2026-06-02T06:56:15.632346Z","end":"2026-06-02T06:56:16.745878Z","steps":["trace[697214218] 'process raft request' (duration: 1.112753014s)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:16.746088Z","caller":"traceutil/trace.go:171","msg":"trace[1456875467] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"850.302906ms","start":"2026-06-02T06:56:15.895744Z","end":"2026-06-02T06:56:16.746047Z","steps":["trace[1456875467] 'process raft request' (duration: 849.818707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:16.746073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:15.625122Z","time spent":"1.120764664s","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:16.746468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:15.632339Z","time spent":"1.113810793s","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:16.746497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:15.895716Z","time spent":"850.46678ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:16.86951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.8732ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-02T06:56:16.869696Z","caller":"traceutil/trace.go:171","msg":"trace[1052236862] linearizableReadLoop","detail":"{readStateIndex:4915; appliedIndex:4912; }","duration":"650.81933ms","start":"2026-06-02T06:56:16.218798Z","end":"2026-06-02T06:56:16.869617Z","steps":["trace[1052236862] 'read index received' (duration: 252.327928ms)","trace[1052236862] 'applied index is now lower than readState.Index' (duration: 398.489432ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:16.869809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.886934ms","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-06-02T06:56:16.869817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.82842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9f165080-37fa-4ee6-8242-a53c9d63350b\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-06-02T06:56:16.869878Z","caller":"traceutil/trace.go:171","msg":"trace[761474908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4732; }","duration":"807.036426ms","start":"2026-06-02T06:56:16.062825Z","end":"2026-06-02T06:56:16.869861Z","steps":["trace[761474908] 'agreement among raft nodes before linearized reading' (duration: 806.807872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:16.86992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.062799Z","time spent":"807.115318ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T06:56:16.870115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248314085s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:56746"} {"level":"warn","ts":"2026-06-02T06:56:16.870128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.590292ms","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-06-02T06:56:16.870139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.276239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7921e2c5-3737-4fd9-8781-b5a9005a1e27\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-06-02T06:56:16.870163Z","caller":"traceutil/trace.go:171","msg":"trace[1084811125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4732; }","duration":"728.685083ms","start":"2026-06-02T06:56:16.14147Z","end":"2026-06-02T06:56:16.870156Z","steps":["trace[1084811125] 'agreement among raft nodes before linearized reading' (duration: 728.573641ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:16.870215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.141418Z","time spent":"728.790235ms","remote":"127.0.0.1:49648","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-06-02T06:56:16.870222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.701442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:56:16.870262Z","caller":"traceutil/trace.go:171","msg":"trace[382582615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4732; }","duration":"875.795324ms","start":"2026-06-02T06:56:15.994459Z","end":"2026-06-02T06:56:16.870254Z","steps":["trace[382582615] 'agreement among raft nodes before linearized reading' (duration: 875.738623ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:16.869913Z","caller":"traceutil/trace.go:171","msg":"trace[248220696] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9f165080-37fa-4ee6-8242-a53c9d63350b; range_end:; response_count:1; response_revision:4732; }","duration":"712.934582ms","start":"2026-06-02T06:56:16.156954Z","end":"2026-06-02T06:56:16.869889Z","steps":["trace[248220696] 'agreement among raft nodes before linearized reading' (duration: 712.699348ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:16.870299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:15.994431Z","time spent":"875.860615ms","remote":"127.0.0.1:49392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T06:56:16.870308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.156943Z","time spent":"713.35764ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3783,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9f165080-37fa-4ee6-8242-a53c9d63350b\" "} {"level":"warn","ts":"2026-06-02T06:56:16.870448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014899219s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7921e2c5-3737-4fd9-8781-b5a9005a1e27\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-06-02T06:56:16.870499Z","caller":"traceutil/trace.go:171","msg":"trace[74213665] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7921e2c5-3737-4fd9-8781-b5a9005a1e27; range_end:; response_count:1; response_revision:4732; }","duration":"1.015002631s","start":"2026-06-02T06:56:15.855484Z","end":"2026-06-02T06:56:16.870487Z","steps":["trace[74213665] 'agreement among raft nodes before linearized reading' (duration: 1.014811268s)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:16.870175Z","caller":"traceutil/trace.go:171","msg":"trace[1106993436] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4732; }","duration":"1.248392157s","start":"2026-06-02T06:56:15.621758Z","end":"2026-06-02T06:56:16.87015Z","steps":["trace[1106993436] 'agreement among raft nodes before linearized reading' (duration: 1.248195564s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:16.870583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:15.855456Z","time spent":"1.015111612s","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3797,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7921e2c5-3737-4fd9-8781-b5a9005a1e27\" "} {"level":"warn","ts":"2026-06-02T06:56:16.870612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:15.621739Z","time spent":"1.248860785s","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":6,"response size":56769,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "} {"level":"info","ts":"2026-06-02T06:56:16.870216Z","caller":"traceutil/trace.go:171","msg":"trace[1529027551] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7921e2c5-3737-4fd9-8781-b5a9005a1e27; range_end:; response_count:1; response_revision:4732; }","duration":"815.389231ms","start":"2026-06-02T06:56:16.054781Z","end":"2026-06-02T06:56:16.87017Z","steps":["trace[1529027551] 'agreement among raft nodes before linearized reading' (duration: 815.097556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:16.870848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.054745Z","time spent":"816.091083ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3797,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7921e2c5-3737-4fd9-8781-b5a9005a1e27\" "} {"level":"warn","ts":"2026-06-02T06:56:16.870864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.68936ms","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":"info","ts":"2026-06-02T06:56:16.871024Z","caller":"traceutil/trace.go:171","msg":"trace[2118519802] 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:4732; }","duration":"345.860892ms","start":"2026-06-02T06:56:16.52513Z","end":"2026-06-02T06:56:16.870991Z","steps":["trace[2118519802] 'agreement among raft nodes before linearized reading' (duration: 345.690569ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:16.87106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.525117Z","time spent":"345.928433ms","remote":"127.0.0.1:33246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:56:16.871426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.0421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-02T06:56:16.87149Z","caller":"traceutil/trace.go:171","msg":"trace[1668007253] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4732; }","duration":"355.109141ms","start":"2026-06-02T06:56:16.516366Z","end":"2026-06-02T06:56:16.871475Z","steps":["trace[1668007253] 'agreement among raft nodes before linearized reading' (duration: 353.85163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:16.871528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.516306Z","time spent":"355.211643ms","remote":"127.0.0.1:49486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206996,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-06-02T06:56:17.088498Z","caller":"traceutil/trace.go:171","msg":"trace[575400346] linearizableReadLoop","detail":"{readStateIndex:4917; appliedIndex:4916; }","duration":"211.490441ms","start":"2026-06-02T06:56:16.876978Z","end":"2026-06-02T06:56:17.088469Z","steps":["trace[575400346] 'read index received' (duration: 211.40379ms)","trace[575400346] 'applied index is now lower than readState.Index' (duration: 81.721µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:17.088645Z","caller":"traceutil/trace.go:171","msg":"trace[905876449] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"212.323166ms","start":"2026-06-02T06:56:16.876285Z","end":"2026-06-02T06:56:17.088608Z","steps":["trace[905876449] 'process raft request' (duration: 211.98414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:17.088877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.833177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T06:56:17.089005Z","caller":"traceutil/trace.go:171","msg":"trace[713232897] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:4733; }","duration":"211.959419ms","start":"2026-06-02T06:56:16.876954Z","end":"2026-06-02T06:56:17.088913Z","steps":["trace[713232897] 'agreement among raft nodes before linearized reading' (duration: 211.660074ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:17.533772Z","caller":"traceutil/trace.go:171","msg":"trace[1447018659] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"656.423174ms","start":"2026-06-02T06:56:16.877303Z","end":"2026-06-02T06:56:17.533726Z","steps":["trace[1447018659] 'process raft request' (duration: 656.056628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:17.534026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.87729Z","time spent":"656.615568ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:56:17.533778Z","caller":"traceutil/trace.go:171","msg":"trace[1803298451] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"656.15173ms","start":"2026-06-02T06:56:16.877589Z","end":"2026-06-02T06:56:17.53374Z","steps":["trace[1803298451] 'process raft request' (duration: 655.993567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:17.534241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.877564Z","time spent":"656.574056ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:56:17.534246Z","caller":"traceutil/trace.go:171","msg":"trace[591478695] transaction","detail":"{read_only:false; response_revision:4737; number_of_response:1; }","duration":"642.454072ms","start":"2026-06-02T06:56:16.89177Z","end":"2026-06-02T06:56:17.534224Z","steps":["trace[591478695] 'process raft request' (duration: 642.162017ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:17.534237Z","caller":"traceutil/trace.go:171","msg":"trace[1136974193] transaction","detail":"{read_only:false; response_revision:4736; number_of_response:1; }","duration":"653.806468ms","start":"2026-06-02T06:56:16.880374Z","end":"2026-06-02T06:56:17.534181Z","steps":["trace[1136974193] 'process raft request' (duration: 653.283009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:17.534359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.891747Z","time spent":"642.565264ms","remote":"127.0.0.1:41572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7450,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:17.534547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.880352Z","time spent":"654.030002ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3879,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:56:17.534708Z","caller":"traceutil/trace.go:171","msg":"trace[1458583220] linearizableReadLoop","detail":"{readStateIndex:4921; appliedIndex:4917; }","duration":"446.111854ms","start":"2026-06-02T06:56:17.088577Z","end":"2026-06-02T06:56:17.534689Z","steps":["trace[1458583220] 'read index received' (duration: 444.679899ms)","trace[1458583220] 'applied index is now lower than readState.Index' (duration: 1.429915ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:17.534903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.899406ms","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-06-02T06:56:17.534935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.166679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-02T06:56:17.534985Z","caller":"traceutil/trace.go:171","msg":"trace[664493971] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4737; }","duration":"616.28099ms","start":"2026-06-02T06:56:16.918693Z","end":"2026-06-02T06:56:17.534974Z","steps":["trace[664493971] 'agreement among raft nodes before linearized reading' (duration: 616.118428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:17.535018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.918674Z","time spent":"616.336262ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-02T06:56:17.534944Z","caller":"traceutil/trace.go:171","msg":"trace[939771033] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4737; }","duration":"607.991958ms","start":"2026-06-02T06:56:16.92694Z","end":"2026-06-02T06:56:17.534932Z","steps":["trace[939771033] 'agreement among raft nodes before linearized reading' (duration: 607.853435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:17.535156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.198094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:56:17.535192Z","caller":"traceutil/trace.go:171","msg":"trace[894856538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4737; }","duration":"105.274825ms","start":"2026-06-02T06:56:17.429906Z","end":"2026-06-02T06:56:17.535181Z","steps":["trace[894856538] 'agreement among raft nodes before linearized reading' (duration: 105.215174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:17.53519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.926917Z","time spent":"608.250962ms","remote":"127.0.0.1:49648","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-06-02T06:56:17.535374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.016631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-06-02T06:56:17.535409Z","caller":"traceutil/trace.go:171","msg":"trace[103591328] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4737; }","duration":"625.064503ms","start":"2026-06-02T06:56:16.910334Z","end":"2026-06-02T06:56:17.535398Z","steps":["trace[103591328] 'agreement among raft nodes before linearized reading' (duration: 624.959561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:17.535441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.910325Z","time spent":"625.108163ms","remote":"127.0.0.1:49480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1844,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-06-02T06:56:17.535656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.036636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-02T06:56:17.535694Z","caller":"traceutil/trace.go:171","msg":"trace[73875187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4737; }","duration":"616.097546ms","start":"2026-06-02T06:56:16.919586Z","end":"2026-06-02T06:56:17.535683Z","steps":["trace[73875187] 'agreement among raft nodes before linearized reading' (duration: 615.11432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:17.535722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:16.91957Z","time spent":"616.144917ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-02T06:56:17.672394Z","caller":"traceutil/trace.go:171","msg":"trace[358606534] transaction","detail":"{read_only:false; response_revision:4738; number_of_response:1; }","duration":"130.769475ms","start":"2026-06-02T06:56:17.541589Z","end":"2026-06-02T06:56:17.672358Z","steps":["trace[358606534] 'process raft request' (duration: 130.47868ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:17.701682Z","caller":"traceutil/trace.go:171","msg":"trace[1503947768] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"158.469743ms","start":"2026-06-02T06:56:17.543179Z","end":"2026-06-02T06:56:17.701649Z","steps":["trace[1503947768] 'process raft request' (duration: 158.147338ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:17.701763Z","caller":"traceutil/trace.go:171","msg":"trace[1864574244] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"158.382842ms","start":"2026-06-02T06:56:17.543317Z","end":"2026-06-02T06:56:17.7017Z","steps":["trace[1864574244] 'process raft request' (duration: 158.209319ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:17.701895Z","caller":"traceutil/trace.go:171","msg":"trace[1750726560] linearizableReadLoop","detail":"{readStateIndex:4925; appliedIndex:4921; }","duration":"137.038703ms","start":"2026-06-02T06:56:17.564818Z","end":"2026-06-02T06:56:17.701857Z","steps":["trace[1750726560] 'read index received' (duration: 107.30035ms)","trace[1750726560] 'applied index is now lower than readState.Index' (duration: 29.735783ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:17.702131Z","caller":"traceutil/trace.go:171","msg":"trace[839124424] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"154.892791ms","start":"2026-06-02T06:56:17.547223Z","end":"2026-06-02T06:56:17.702116Z","steps":["trace[839124424] 'process raft request' (duration: 154.358892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:17.702503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.643833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-06-02T06:56:17.702561Z","caller":"traceutil/trace.go:171","msg":"trace[579836850] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4741; }","duration":"137.759096ms","start":"2026-06-02T06:56:17.564786Z","end":"2026-06-02T06:56:17.702545Z","steps":["trace[579836850] 'agreement among raft nodes before linearized reading' (duration: 137.231057ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:17.825776Z","caller":"traceutil/trace.go:171","msg":"trace[893667760] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"116.220184ms","start":"2026-06-02T06:56:17.709508Z","end":"2026-06-02T06:56:17.825728Z","steps":["trace[893667760] 'process raft request' (duration: 77.357754ms)","trace[893667760] 'compare' (duration: 38.145608ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:17.826666Z","caller":"traceutil/trace.go:171","msg":"trace[626178336] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"106.000258ms","start":"2026-06-02T06:56:17.719848Z","end":"2026-06-02T06:56:17.825848Z","steps":["trace[626178336] 'process raft request' (duration: 105.481059ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:18.078274Z","caller":"traceutil/trace.go:171","msg":"trace[38642732] linearizableReadLoop","detail":"{readStateIndex:4931; appliedIndex:4929; }","duration":"135.81687ms","start":"2026-06-02T06:56:17.942431Z","end":"2026-06-02T06:56:18.078247Z","steps":["trace[38642732] 'read index received' (duration: 14.550431ms)","trace[38642732] 'applied index is now lower than readState.Index' (duration: 121.265409ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:18.078386Z","caller":"traceutil/trace.go:171","msg":"trace[1824560473] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"143.003935ms","start":"2026-06-02T06:56:17.935332Z","end":"2026-06-02T06:56:18.078336Z","steps":["trace[1824560473] 'process raft request' (duration: 142.71613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:18.078485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.017284ms","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-06-02T06:56:18.078517Z","caller":"traceutil/trace.go:171","msg":"trace[453277973] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4746; }","duration":"136.135116ms","start":"2026-06-02T06:56:17.942372Z","end":"2026-06-02T06:56:18.078507Z","steps":["trace[453277973] 'agreement among raft nodes before linearized reading' (duration: 135.999003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:18.105811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.64793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:56:18.105871Z","caller":"traceutil/trace.go:171","msg":"trace[572257047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4747; }","duration":"127.771842ms","start":"2026-06-02T06:56:17.978086Z","end":"2026-06-02T06:56:18.105858Z","steps":["trace[572257047] 'agreement among raft nodes before linearized reading' (duration: 127.590039ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:20.875452Z","caller":"traceutil/trace.go:171","msg":"trace[897996228] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"114.08741ms","start":"2026-06-02T06:56:20.761336Z","end":"2026-06-02T06:56:20.875424Z","steps":["trace[897996228] 'process raft request' (duration: 113.898207ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:20.876941Z","caller":"traceutil/trace.go:171","msg":"trace[858182938] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"111.528707ms","start":"2026-06-02T06:56:20.765395Z","end":"2026-06-02T06:56:20.876923Z","steps":["trace[858182938] 'process raft request' (duration: 111.459776ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:20.877099Z","caller":"traceutil/trace.go:171","msg":"trace[66890778] transaction","detail":"{read_only:false; response_revision:4800; number_of_response:1; }","duration":"113.154764ms","start":"2026-06-02T06:56:20.763882Z","end":"2026-06-02T06:56:20.877037Z","steps":["trace[66890778] 'process raft request' (duration: 112.870889ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.259078Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496657659546383589,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-02T06:56:28.445689Z","caller":"traceutil/trace.go:171","msg":"trace[573556940] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"694.494508ms","start":"2026-06-02T06:56:27.751168Z","end":"2026-06-02T06:56:28.445663Z","steps":["trace[573556940] 'process raft request' (duration: 694.269784ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:28.44566Z","caller":"traceutil/trace.go:171","msg":"trace[1428508948] linearizableReadLoop","detail":"{readStateIndex:5082; appliedIndex:5081; }","duration":"687.573949ms","start":"2026-06-02T06:56:27.758053Z","end":"2026-06-02T06:56:28.445627Z","steps":["trace[1428508948] 'read index received' (duration: 687.355045ms)","trace[1428508948] 'applied index is now lower than readState.Index' (duration: 214.394µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:28.445883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.831274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-02T06:56:28.446054Z","caller":"traceutil/trace.go:171","msg":"trace[612366828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4890; }","duration":"688.003976ms","start":"2026-06-02T06:56:27.758004Z","end":"2026-06-02T06:56:28.446008Z","steps":["trace[612366828] 'agreement among raft nodes before linearized reading' (duration: 687.725762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.446185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:27.75794Z","time spent":"688.198509ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T06:56:28.446694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.371459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-02T06:56:28.446742Z","caller":"traceutil/trace.go:171","msg":"trace[822418566] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4890; }","duration":"683.46507ms","start":"2026-06-02T06:56:27.763264Z","end":"2026-06-02T06:56:28.446729Z","steps":["trace[822418566] 'agreement among raft nodes before linearized reading' (duration: 683.277207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.446772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:27.763239Z","time spent":"683.525761ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-02T06:56:28.44588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:27.751138Z","time spent":"694.62642ms","remote":"127.0.0.1:49456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:28.447117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.496032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T06:56:28.447156Z","caller":"traceutil/trace.go:171","msg":"trace[1191973493] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:4890; }","duration":"143.581503ms","start":"2026-06-02T06:56:28.303566Z","end":"2026-06-02T06:56:28.447147Z","steps":["trace[1191973493] 'agreement among raft nodes before linearized reading' (duration: 143.487352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.447364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.011865ms","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-06-02T06:56:28.447409Z","caller":"traceutil/trace.go:171","msg":"trace[1483478300] 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:4890; }","duration":"393.051105ms","start":"2026-06-02T06:56:28.054342Z","end":"2026-06-02T06:56:28.447393Z","steps":["trace[1483478300] 'agreement among raft nodes before linearized reading' (duration: 392.956284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.447439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:28.054328Z","time spent":"393.103977ms","remote":"127.0.0.1:49554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-06-02T06:56:28.447557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.506363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T06:56:28.447621Z","caller":"traceutil/trace.go:171","msg":"trace[557812455] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:4890; }","duration":"423.593295ms","start":"2026-06-02T06:56:28.024013Z","end":"2026-06-02T06:56:28.447606Z","steps":["trace[557812455] 'agreement among raft nodes before linearized reading' (duration: 423.435022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.447667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:28.024005Z","time spent":"423.650036ms","remote":"127.0.0.1:51302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":8,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:56:28.448191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.580194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:56:28.448236Z","caller":"traceutil/trace.go:171","msg":"trace[1473198279] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4890; }","duration":"467.667335ms","start":"2026-06-02T06:56:27.980559Z","end":"2026-06-02T06:56:28.448227Z","steps":["trace[1473198279] 'agreement among raft nodes before linearized reading' (duration: 467.599714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.448316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:27.980533Z","time spent":"467.771287ms","remote":"127.0.0.1:49392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T06:56:28.448974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.641567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-06-02T06:56:28.449045Z","caller":"traceutil/trace.go:171","msg":"trace[1126586576] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4890; }","duration":"429.75087ms","start":"2026-06-02T06:56:28.019278Z","end":"2026-06-02T06:56:28.449029Z","steps":["trace[1126586576] 'agreement among raft nodes before linearized reading' (duration: 428.890885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.449103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:28.019256Z","time spent":"429.829891ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12998,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-06-02T06:56:28.679014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.514689ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:56:28.679133Z","caller":"traceutil/trace.go:171","msg":"trace[1082791529] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"225.301742ms","start":"2026-06-02T06:56:28.453812Z","end":"2026-06-02T06:56:28.679114Z","steps":["trace[1082791529] 'process raft request' (duration: 87.58946ms)","trace[1082791529] 'compare' (duration: 137.150753ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:28.681448Z","caller":"traceutil/trace.go:171","msg":"trace[564002155] linearizableReadLoop","detail":"{readStateIndex:5084; appliedIndex:5082; }","duration":"226.448502ms","start":"2026-06-02T06:56:28.454982Z","end":"2026-06-02T06:56:28.68143Z","steps":["trace[564002155] 'read index received' (duration: 86.4441ms)","trace[564002155] 'applied index is now lower than readState.Index' (duration: 140.002822ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:28.681783Z","caller":"traceutil/trace.go:171","msg":"trace[184151076] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"218.337503ms","start":"2026-06-02T06:56:28.46343Z","end":"2026-06-02T06:56:28.681768Z","steps":["trace[184151076] 'process raft request' (duration: 217.936077ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:28.681887Z","caller":"traceutil/trace.go:171","msg":"trace[475675457] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"228.001698ms","start":"2026-06-02T06:56:28.453871Z","end":"2026-06-02T06:56:28.681872Z","steps":["trace[475675457] 'process raft request' (duration: 227.414908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.682244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.239095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7f77cdbcc6-xfnr8.18b53141f2b34292\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-06-02T06:56:28.682297Z","caller":"traceutil/trace.go:171","msg":"trace[1448004977] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-7f77cdbcc6-xfnr8.18b53141f2b34292; range_end:; response_count:1; response_revision:4893; }","duration":"227.318007ms","start":"2026-06-02T06:56:28.454966Z","end":"2026-06-02T06:56:28.682284Z","steps":["trace[1448004977] 'agreement among raft nodes before linearized reading' (duration: 227.105373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.69236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.130343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-02T06:56:28.69244Z","caller":"traceutil/trace.go:171","msg":"trace[1724479158] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4894; }","duration":"234.237335ms","start":"2026-06-02T06:56:28.458184Z","end":"2026-06-02T06:56:28.692421Z","steps":["trace[1724479158] 'agreement among raft nodes before linearized reading' (duration: 234.034961ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:28.794231Z","caller":"traceutil/trace.go:171","msg":"trace[417793468] linearizableReadLoop","detail":"{readStateIndex:5091; appliedIndex:5086; }","duration":"102.095687ms","start":"2026-06-02T06:56:28.692108Z","end":"2026-06-02T06:56:28.794203Z","steps":["trace[417793468] 'read index received' (duration: 85.571606ms)","trace[417793468] 'applied index is now lower than readState.Index' (duration: 16.52268ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:28.794598Z","caller":"traceutil/trace.go:171","msg":"trace[825617115] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"105.065398ms","start":"2026-06-02T06:56:28.689512Z","end":"2026-06-02T06:56:28.794578Z","steps":["trace[825617115] 'process raft request' (duration: 89.383951ms)","trace[825617115] 'compare' (duration: 15.146807ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:28.794984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.208654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-06-02T06:56:28.795056Z","caller":"traceutil/trace.go:171","msg":"trace[1502339518] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4899; }","duration":"107.337026ms","start":"2026-06-02T06:56:28.687701Z","end":"2026-06-02T06:56:28.795038Z","steps":["trace[1502339518] 'agreement among raft nodes before linearized reading' (duration: 107.092492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.795336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.25757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:56:28.795419Z","caller":"traceutil/trace.go:171","msg":"trace[146520506] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4899; }","duration":"102.327501ms","start":"2026-06-02T06:56:28.693052Z","end":"2026-06-02T06:56:28.79538Z","steps":["trace[146520506] 'agreement among raft nodes before linearized reading' (duration: 102.23505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:28.795903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.907267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9f165080-37fa-4ee6-8242-a53c9d63350b\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-06-02T06:56:28.795965Z","caller":"traceutil/trace.go:171","msg":"trace[1362465525] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9f165080-37fa-4ee6-8242-a53c9d63350b; range_end:; response_count:1; response_revision:4899; }","duration":"100.980138ms","start":"2026-06-02T06:56:28.69497Z","end":"2026-06-02T06:56:28.79595Z","steps":["trace[1362465525] 'agreement among raft nodes before linearized reading' (duration: 100.823365ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:29.118684Z","caller":"traceutil/trace.go:171","msg":"trace[1534609215] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"170.810913ms","start":"2026-06-02T06:56:28.947847Z","end":"2026-06-02T06:56:29.118657Z","steps":["trace[1534609215] 'process raft request' (duration: 170.541029ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:29.119152Z","caller":"traceutil/trace.go:171","msg":"trace[1979496600] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"171.213639ms","start":"2026-06-02T06:56:28.947865Z","end":"2026-06-02T06:56:29.119078Z","steps":["trace[1979496600] 'process raft request' (duration: 170.731851ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:29.11935Z","caller":"traceutil/trace.go:171","msg":"trace[547409630] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"171.19159ms","start":"2026-06-02T06:56:28.94808Z","end":"2026-06-02T06:56:29.119271Z","steps":["trace[547409630] 'process raft request' (duration: 170.834294ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:29.119631Z","caller":"traceutil/trace.go:171","msg":"trace[507026059] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"171.271072ms","start":"2026-06-02T06:56:28.94813Z","end":"2026-06-02T06:56:29.119401Z","steps":["trace[507026059] 'process raft request' (duration: 171.070237ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:29.126256Z","caller":"traceutil/trace.go:171","msg":"trace[1571550598] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"150.024789ms","start":"2026-06-02T06:56:28.976217Z","end":"2026-06-02T06:56:29.126242Z","steps":["trace[1571550598] 'process raft request' (duration: 148.594085ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:29.760807Z","caller":"traceutil/trace.go:171","msg":"trace[1366700360] linearizableReadLoop","detail":"{readStateIndex:5103; appliedIndex:5102; }","duration":"568.890354ms","start":"2026-06-02T06:56:29.191876Z","end":"2026-06-02T06:56:29.760766Z","steps":["trace[1366700360] 'read index received' (duration: 471.193506ms)","trace[1366700360] 'applied index is now lower than readState.Index' (duration: 97.695248ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:29.761827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.921832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-7921e2c5-3737-4fd9-8781-b5a9005a1e27\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-06-02T06:56:29.761934Z","caller":"traceutil/trace.go:171","msg":"trace[1102356005] range","detail":"{range_begin:/registry/persistentvolumes/pvc-7921e2c5-3737-4fd9-8781-b5a9005a1e27; range_end:; response_count:1; response_revision:4911; }","duration":"570.064075ms","start":"2026-06-02T06:56:29.191847Z","end":"2026-06-02T06:56:29.761911Z","steps":["trace[1102356005] 'agreement among raft nodes before linearized reading' (duration: 569.049128ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:29.760856Z","caller":"traceutil/trace.go:171","msg":"trace[1985382360] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"569.638467ms","start":"2026-06-02T06:56:29.191138Z","end":"2026-06-02T06:56:29.760776Z","steps":["trace[1985382360] 'process raft request' (duration: 471.910467ms)","trace[1985382360] 'compare' (duration: 97.559167ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:29.762135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:29.191834Z","time spent":"570.135447ms","remote":"127.0.0.1:49546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1473,"request content":"key:\"/registry/persistentvolumes/pvc-7921e2c5-3737-4fd9-8781-b5a9005a1e27\" "} {"level":"warn","ts":"2026-06-02T06:56:29.762279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:29.191122Z","time spent":"570.931929ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:29.982685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.522795ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:56:29.982814Z","caller":"traceutil/trace.go:171","msg":"trace[356924455] linearizableReadLoop","detail":"{readStateIndex:5104; appliedIndex:5103; }","duration":"221.884369ms","start":"2026-06-02T06:56:29.760907Z","end":"2026-06-02T06:56:29.982792Z","steps":["trace[356924455] 'read index received' (duration: 106.992297ms)","trace[356924455] 'applied index is now lower than readState.Index' (duration: 114.890422ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:29.982931Z","caller":"traceutil/trace.go:171","msg":"trace[1446413907] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"746.571913ms","start":"2026-06-02T06:56:29.236345Z","end":"2026-06-02T06:56:29.982917Z","steps":["trace[1446413907] 'process raft request' (duration: 631.704662ms)","trace[1446413907] 'compare' (duration: 114.382493ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:29.983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:29.236301Z","time spent":"746.663485ms","remote":"127.0.0.1:43564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2725,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:29.983022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.453603ms","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-06-02T06:56:29.983107Z","caller":"traceutil/trace.go:171","msg":"trace[1512264940] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4912; }","duration":"380.604046ms","start":"2026-06-02T06:56:29.602484Z","end":"2026-06-02T06:56:29.983088Z","steps":["trace[1512264940] 'agreement among raft nodes before linearized reading' (duration: 380.422043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:29.983139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:29.602456Z","time spent":"380.675387ms","remote":"127.0.0.1:49648","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-06-02T06:56:29.983356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.031161ms","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-06-02T06:56:29.983375Z","caller":"traceutil/trace.go:171","msg":"trace[1595501271] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4912; }","duration":"229.109753ms","start":"2026-06-02T06:56:29.754259Z","end":"2026-06-02T06:56:29.983369Z","steps":["trace[1595501271] 'agreement among raft nodes before linearized reading' (duration: 229.042451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:29.98352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.3298ms","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-06-02T06:56:29.98354Z","caller":"traceutil/trace.go:171","msg":"trace[45394701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4912; }","duration":"377.370681ms","start":"2026-06-02T06:56:29.606163Z","end":"2026-06-02T06:56:29.983534Z","steps":["trace[45394701] 'agreement among raft nodes before linearized reading' (duration: 377.30502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:29.983581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:29.606151Z","time spent":"377.424562ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T06:56:30.471253Z","caller":"traceutil/trace.go:171","msg":"trace[1582366961] linearizableReadLoop","detail":"{readStateIndex:5113; appliedIndex:5112; }","duration":"324.452406ms","start":"2026-06-02T06:56:30.146768Z","end":"2026-06-02T06:56:30.47122Z","steps":["trace[1582366961] 'read index received' (duration: 324.148421ms)","trace[1582366961] 'applied index is now lower than readState.Index' (duration: 302.165µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:30.471317Z","caller":"traceutil/trace.go:171","msg":"trace[1544260918] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"343.386356ms","start":"2026-06-02T06:56:30.127887Z","end":"2026-06-02T06:56:30.471273Z","steps":["trace[1544260918] 'process raft request' (duration: 342.985999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:30.471529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:30.127866Z","time spent":"343.549859ms","remote":"127.0.0.1:49430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":129368,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:30.471611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.812572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-02T06:56:30.471677Z","caller":"traceutil/trace.go:171","msg":"trace[1719480743] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4921; }","duration":"324.974224ms","start":"2026-06-02T06:56:30.146689Z","end":"2026-06-02T06:56:30.471663Z","steps":["trace[1719480743] 'agreement among raft nodes before linearized reading' (duration: 324.652689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:30.471727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:30.146662Z","time spent":"325.049685ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-02T06:56:32.292217Z","caller":"traceutil/trace.go:171","msg":"trace[1187256025] linearizableReadLoop","detail":"{readStateIndex:5176; appliedIndex:5175; }","duration":"240.38285ms","start":"2026-06-02T06:56:32.051814Z","end":"2026-06-02T06:56:32.292197Z","steps":["trace[1187256025] 'read index received' (duration: 240.285098ms)","trace[1187256025] 'applied index is now lower than readState.Index' (duration: 96.692µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:32.292344Z","caller":"traceutil/trace.go:171","msg":"trace[395378744] transaction","detail":"{read_only:false; response_revision:4983; number_of_response:1; }","duration":"244.538139ms","start":"2026-06-02T06:56:32.047797Z","end":"2026-06-02T06:56:32.292335Z","steps":["trace[395378744] 'process raft request' (duration: 244.240284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:32.292736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.895458ms","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-06-02T06:56:32.292769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.934835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-91596e34-f5cf-49a5-b997-501d3d3516a3\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-02T06:56:32.292843Z","caller":"traceutil/trace.go:171","msg":"trace[805672600] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-91596e34-f5cf-49a5-b997-501d3d3516a3; range_end:; response_count:1; response_revision:4983; }","duration":"232.055767ms","start":"2026-06-02T06:56:32.060769Z","end":"2026-06-02T06:56:32.292825Z","steps":["trace[805672600] 'agreement among raft nodes before linearized reading' (duration: 231.855724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:32.292769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.242866ms","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-06-02T06:56:32.293879Z","caller":"traceutil/trace.go:171","msg":"trace[1275435459] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4983; }","duration":"241.395367ms","start":"2026-06-02T06:56:32.052462Z","end":"2026-06-02T06:56:32.293857Z","steps":["trace[1275435459] 'agreement among raft nodes before linearized reading' (duration: 240.020483ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:32.292833Z","caller":"traceutil/trace.go:171","msg":"trace[1641825103] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4983; }","duration":"241.01501ms","start":"2026-06-02T06:56:32.051797Z","end":"2026-06-02T06:56:32.292812Z","steps":["trace[1641825103] 'agreement among raft nodes before linearized reading' (duration: 240.803347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:33.411289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.418229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T06:56:33.411381Z","caller":"traceutil/trace.go:171","msg":"trace[2126976547] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:4994; }","duration":"271.583392ms","start":"2026-06-02T06:56:33.139777Z","end":"2026-06-02T06:56:33.41136Z","steps":["trace[2126976547] 'count revisions from in-memory index tree' (duration: 271.327147ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:36.216697Z","caller":"traceutil/trace.go:171","msg":"trace[1497893858] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"193.007002ms","start":"2026-06-02T06:56:36.023656Z","end":"2026-06-02T06:56:36.216663Z","steps":["trace[1497893858] 'process raft request' (duration: 192.798129ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:43.969351Z","caller":"traceutil/trace.go:171","msg":"trace[597822375] transaction","detail":"{read_only:false; response_revision:5122; number_of_response:1; }","duration":"240.633051ms","start":"2026-06-02T06:56:43.728683Z","end":"2026-06-02T06:56:43.969316Z","steps":["trace[597822375] 'process raft request' (duration: 240.392277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:48.310307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.725849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:56:48.310405Z","caller":"traceutil/trace.go:171","msg":"trace[1396237790] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:5158; }","duration":"137.897042ms","start":"2026-06-02T06:56:48.172486Z","end":"2026-06-02T06:56:48.310383Z","steps":["trace[1396237790] 'count revisions from in-memory index tree' (duration: 137.519246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:48.310577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.510529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:56:48.310673Z","caller":"traceutil/trace.go:171","msg":"trace[1884541548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5158; }","duration":"329.683831ms","start":"2026-06-02T06:56:47.980969Z","end":"2026-06-02T06:56:48.310653Z","steps":["trace[1884541548] 'range keys from in-memory index tree' (duration: 329.301535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:48.310706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:47.980938Z","time spent":"329.762692ms","remote":"127.0.0.1:49392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T06:56:48.310755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.360325ms","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-06-02T06:56:48.310825Z","caller":"traceutil/trace.go:171","msg":"trace[1986311943] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5158; }","duration":"273.484936ms","start":"2026-06-02T06:56:48.037323Z","end":"2026-06-02T06:56:48.310808Z","steps":["trace[1986311943] 'range keys from in-memory index tree' (duration: 273.049639ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:48.755427Z","caller":"traceutil/trace.go:171","msg":"trace[1503336741] transaction","detail":"{read_only:false; response_revision:5159; number_of_response:1; }","duration":"438.975439ms","start":"2026-06-02T06:56:48.316415Z","end":"2026-06-02T06:56:48.755391Z","steps":["trace[1503336741] 'process raft request' (duration: 438.780966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:48.755661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:48.316401Z","time spent":"439.108151ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:56:48.883697Z","caller":"traceutil/trace.go:171","msg":"trace[116452580] linearizableReadLoop","detail":"{readStateIndex:5360; appliedIndex:5358; }","duration":"393.792898ms","start":"2026-06-02T06:56:48.489866Z","end":"2026-06-02T06:56:48.883659Z","steps":["trace[116452580] 'read index received' (duration: 265.384252ms)","trace[116452580] 'applied index is now lower than readState.Index' (duration: 128.407356ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:48.883861Z","caller":"traceutil/trace.go:171","msg":"trace[104112469] transaction","detail":"{read_only:false; response_revision:5160; number_of_response:1; }","duration":"560.788384ms","start":"2026-06-02T06:56:48.323058Z","end":"2026-06-02T06:56:48.883847Z","steps":["trace[104112469] 'process raft request' (duration: 555.707639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:48.884005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:48.323026Z","time spent":"560.866755ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:48.884286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.994468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T06:56:48.884374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.367714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:56:48.884412Z","caller":"traceutil/trace.go:171","msg":"trace[1616090487] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:5160; }","duration":"392.220682ms","start":"2026-06-02T06:56:48.492157Z","end":"2026-06-02T06:56:48.884378Z","steps":["trace[1616090487] 'agreement among raft nodes before linearized reading' (duration: 391.981738ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:48.884431Z","caller":"traceutil/trace.go:171","msg":"trace[1650524399] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:5160; }","duration":"362.447936ms","start":"2026-06-02T06:56:48.521968Z","end":"2026-06-02T06:56:48.884416Z","steps":["trace[1650524399] 'agreement among raft nodes before linearized reading' (duration: 362.347595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:48.884476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:48.521958Z","time spent":"362.508857ms","remote":"127.0.0.1:33150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:56:48.884477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:48.492132Z","time spent":"392.331823ms","remote":"127.0.0.1:41492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-06-02T06:56:48.884702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.048115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-02T06:56:48.884752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.899126ms","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-06-02T06:56:48.884784Z","caller":"traceutil/trace.go:171","msg":"trace[741893662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5160; }","duration":"394.986507ms","start":"2026-06-02T06:56:48.489789Z","end":"2026-06-02T06:56:48.884775Z","steps":["trace[741893662] 'agreement among raft nodes before linearized reading' (duration: 394.850695ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:48.884784Z","caller":"traceutil/trace.go:171","msg":"trace[1638511993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5160; }","duration":"387.148637ms","start":"2026-06-02T06:56:48.497616Z","end":"2026-06-02T06:56:48.884764Z","steps":["trace[1638511993] 'agreement among raft nodes before linearized reading' (duration: 386.931453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:48.88482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:48.489732Z","time spent":"395.054519ms","remote":"127.0.0.1:49648","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-06-02T06:56:48.884835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:48.497608Z","time spent":"387.216208ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T06:56:48.884853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.499989ms","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-06-02T06:56:48.884897Z","caller":"traceutil/trace.go:171","msg":"trace[1613725272] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5160; }","duration":"388.56145ms","start":"2026-06-02T06:56:48.496325Z","end":"2026-06-02T06:56:48.884887Z","steps":["trace[1613725272] 'agreement among raft nodes before linearized reading' (duration: 388.396177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:48.884936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:48.496316Z","time spent":"388.61304ms","remote":"127.0.0.1:49648","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-06-02T06:56:49.108378Z","caller":"traceutil/trace.go:171","msg":"trace[1501836196] transaction","detail":"{read_only:false; response_revision:5165; number_of_response:1; }","duration":"214.323422ms","start":"2026-06-02T06:56:48.894018Z","end":"2026-06-02T06:56:49.108342Z","steps":["trace[1501836196] 'process raft request' (duration: 214.019208ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:49.108796Z","caller":"traceutil/trace.go:171","msg":"trace[666671197] linearizableReadLoop","detail":"{readStateIndex:5368; appliedIndex:5361; }","duration":"164.584845ms","start":"2026-06-02T06:56:48.944189Z","end":"2026-06-02T06:56:49.108774Z","steps":["trace[666671197] 'read index received' (duration: 24.453146ms)","trace[666671197] 'applied index is now lower than readState.Index' (duration: 140.131068ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:49.108923Z","caller":"traceutil/trace.go:171","msg":"trace[585811135] transaction","detail":"{read_only:false; response_revision:5167; number_of_response:1; }","duration":"214.684807ms","start":"2026-06-02T06:56:48.894226Z","end":"2026-06-02T06:56:49.108911Z","steps":["trace[585811135] 'process raft request' (duration: 214.354441ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:49.109052Z","caller":"traceutil/trace.go:171","msg":"trace[572432829] transaction","detail":"{read_only:false; response_revision:5168; number_of_response:1; }","duration":"214.176219ms","start":"2026-06-02T06:56:48.894867Z","end":"2026-06-02T06:56:49.109043Z","steps":["trace[572432829] 'process raft request' (duration: 213.850024ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:49.109031Z","caller":"traceutil/trace.go:171","msg":"trace[1494425584] transaction","detail":"{read_only:false; response_revision:5166; number_of_response:1; }","duration":"214.86891ms","start":"2026-06-02T06:56:48.894129Z","end":"2026-06-02T06:56:49.108998Z","steps":["trace[1494425584] 'process raft request' (duration: 214.165479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:49.109206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.013912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-02T06:56:49.109231Z","caller":"traceutil/trace.go:171","msg":"trace[15346594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5168; }","duration":"165.056283ms","start":"2026-06-02T06:56:48.94417Z","end":"2026-06-02T06:56:49.109226Z","steps":["trace[15346594] 'agreement among raft nodes before linearized reading' (duration: 164.933651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:49.10938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.626763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-02T06:56:49.109404Z","caller":"traceutil/trace.go:171","msg":"trace[2124907785] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5168; }","duration":"129.689705ms","start":"2026-06-02T06:56:48.979706Z","end":"2026-06-02T06:56:49.109396Z","steps":["trace[2124907785] 'agreement among raft nodes before linearized reading' (duration: 129.638804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:49.109516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.738668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-06-02T06:56:49.10955Z","caller":"traceutil/trace.go:171","msg":"trace[1997238404] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5168; }","duration":"113.82978ms","start":"2026-06-02T06:56:48.995716Z","end":"2026-06-02T06:56:49.109546Z","steps":["trace[1997238404] 'agreement among raft nodes before linearized reading' (duration: 113.757009ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:49.317847Z","caller":"traceutil/trace.go:171","msg":"trace[422079676] transaction","detail":"{read_only:false; response_revision:5171; number_of_response:1; }","duration":"185.184225ms","start":"2026-06-02T06:56:49.132629Z","end":"2026-06-02T06:56:49.317813Z","steps":["trace[422079676] 'process raft request' (duration: 184.579036ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:49.317972Z","caller":"traceutil/trace.go:171","msg":"trace[1270671797] transaction","detail":"{read_only:false; response_revision:5172; number_of_response:1; }","duration":"184.914851ms","start":"2026-06-02T06:56:49.133029Z","end":"2026-06-02T06:56:49.317944Z","steps":["trace[1270671797] 'process raft request' (duration: 184.28285ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:49.318124Z","caller":"traceutil/trace.go:171","msg":"trace[782157100] transaction","detail":"{read_only:false; response_revision:5170; number_of_response:1; }","duration":"198.586888ms","start":"2026-06-02T06:56:49.119476Z","end":"2026-06-02T06:56:49.318063Z","steps":["trace[782157100] 'process raft request' (duration: 106.639042ms)","trace[782157100] 'compare' (duration: 90.657695ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:49.318139Z","caller":"traceutil/trace.go:171","msg":"trace[578041536] transaction","detail":"{read_only:false; response_revision:5173; number_of_response:1; }","duration":"184.22131ms","start":"2026-06-02T06:56:49.133869Z","end":"2026-06-02T06:56:49.31809Z","steps":["trace[578041536] 'process raft request' (duration: 183.489028ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:49.648591Z","caller":"traceutil/trace.go:171","msg":"trace[75025271] linearizableReadLoop","detail":"{readStateIndex:5374; appliedIndex:5373; }","duration":"317.090277ms","start":"2026-06-02T06:56:49.33146Z","end":"2026-06-02T06:56:49.64855Z","steps":["trace[75025271] 'read index received' (duration: 284.064068ms)","trace[75025271] 'applied index is now lower than readState.Index' (duration: 33.023729ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:49.648723Z","caller":"traceutil/trace.go:171","msg":"trace[792799465] transaction","detail":"{read_only:false; response_revision:5174; number_of_response:1; }","duration":"317.368561ms","start":"2026-06-02T06:56:49.331304Z","end":"2026-06-02T06:56:49.648673Z","steps":["trace[792799465] 'process raft request' (duration: 284.24501ms)","trace[792799465] 'compare' (duration: 32.507901ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:49.648915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:49.33129Z","time spent":"317.521824ms","remote":"127.0.0.1:49574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17217,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:49.649388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.88571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9f165080-37fa-4ee6-8242-a53c9d63350b\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-06-02T06:56:49.649472Z","caller":"traceutil/trace.go:171","msg":"trace[1865578250] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9f165080-37fa-4ee6-8242-a53c9d63350b; range_end:; response_count:1; response_revision:5174; }","duration":"318.027351ms","start":"2026-06-02T06:56:49.33142Z","end":"2026-06-02T06:56:49.649448Z","steps":["trace[1865578250] 'agreement among raft nodes before linearized reading' (duration: 317.740697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:49.649523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:49.331397Z","time spent":"318.111873ms","remote":"127.0.0.1:49546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1458,"request content":"key:\"/registry/persistentvolumes/pvc-9f165080-37fa-4ee6-8242-a53c9d63350b\" "} {"level":"info","ts":"2026-06-02T06:57:16.708107Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2855} {"level":"info","ts":"2026-06-02T06:57:16.789969Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2855,"took":"80.026035ms","hash":3639546744,"current-db-size-bytes":51326976,"current-db-size":"51 MB","current-db-size-in-use-bytes":27648000,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-02T06:57:16.790054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3639546744,"revision":2855,"compact-revision":-1} {"level":"info","ts":"2026-06-02T06:57:33.445588Z","caller":"traceutil/trace.go:171","msg":"trace[1281113004] transaction","detail":"{read_only:false; response_revision:5524; number_of_response:1; }","duration":"132.612095ms","start":"2026-06-02T06:57:33.312932Z","end":"2026-06-02T06:57:33.445544Z","steps":["trace[1281113004] 'process raft request' (duration: 128.831455ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:57:33.445753Z","caller":"traceutil/trace.go:171","msg":"trace[340504125] transaction","detail":"{read_only:false; response_revision:5525; number_of_response:1; }","duration":"132.365972ms","start":"2026-06-02T06:57:33.313359Z","end":"2026-06-02T06:57:33.445725Z","steps":["trace[340504125] 'process raft request' (duration: 131.728942ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:01:16.434332Z","caller":"traceutil/trace.go:171","msg":"trace[1918907076] transaction","detail":"{read_only:false; response_revision:6983; number_of_response:1; }","duration":"136.994606ms","start":"2026-06-02T07:01:16.297299Z","end":"2026-06-02T07:01:16.434294Z","steps":["trace[1918907076] 'process raft request' (duration: 136.623146ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:01:18.824994Z","caller":"traceutil/trace.go:171","msg":"trace[1427200177] transaction","detail":"{read_only:false; response_revision:7002; number_of_response:1; }","duration":"131.369265ms","start":"2026-06-02T07:01:18.693584Z","end":"2026-06-02T07:01:18.824954Z","steps":["trace[1427200177] 'process raft request' (duration: 128.805454ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:02:16.71531Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5337} {"level":"info","ts":"2026-06-02T07:02:16.796306Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5337,"took":"78.761647ms","hash":2336400050,"current-db-size-bytes":51326976,"current-db-size":"51 MB","current-db-size-in-use-bytes":18337792,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-02T07:02:16.796421Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2336400050,"revision":5337,"compact-revision":2855} {"level":"info","ts":"2026-06-02T07:03:29.366685Z","caller":"traceutil/trace.go:171","msg":"trace[1762965345] transaction","detail":"{read_only:false; response_revision:7742; number_of_response:1; }","duration":"140.701839ms","start":"2026-06-02T07:03:29.225952Z","end":"2026-06-02T07:03:29.366654Z","steps":["trace[1762965345] 'process raft request' (duration: 119.366621ms)","trace[1762965345] 'compare' (duration: 21.075841ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:03:29.366933Z","caller":"traceutil/trace.go:171","msg":"trace[215878650] transaction","detail":"{read_only:false; response_revision:7743; number_of_response:1; }","duration":"132.666272ms","start":"2026-06-02T07:03:29.23421Z","end":"2026-06-02T07:03:29.366876Z","steps":["trace[215878650] 'process raft request' (duration: 132.385435ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:03:37.148893Z","caller":"traceutil/trace.go:171","msg":"trace[414419236] transaction","detail":"{read_only:false; response_revision:7782; number_of_response:1; }","duration":"113.278865ms","start":"2026-06-02T07:03:37.03558Z","end":"2026-06-02T07:03:37.148859Z","steps":["trace[414419236] 'process raft request' (duration: 80.916718ms)","trace[414419236] 'compare' (duration: 31.787693ms)"],"step_count":2}