{"level":"warn","ts":"2026-05-08T21:07:41.441617Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T21:07:41.441746Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-08T21:07:41.441812Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T21:07:41.441822Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-05-08T21:07:41.441839Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-08T21:07:41.442481Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-05-08T21:07:41.442574Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-08T21:07:41.447381Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.612838ms"} {"level":"info","ts":"2026-05-08T21:07:41.454208Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-05-08T21:07:41.454287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T21:07:41.454311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-05-08T21:07:41.454331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T21:07:41.454341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-05-08T21:07:41.454379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-05-08T21:07:41.465777Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T21:07:41.467636Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T21:07:41.46886Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-08T21:07:41.477435Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T21:07:41.477685Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T21:07:41.486148Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T21:07:41.486541Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T21:07:41.486569Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T21:07:41.486719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-05-08T21:07:41.487008Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-05-08T21:07:41.4906Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-08T21:07:41.490678Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-05-08T21:07:41.490934Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-05-08T21:07:41.493097Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T21:07:41.493144Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T21:07:42.45543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T21:07:42.455511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T21:07:42.45555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-05-08T21:07:42.455581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-05-08T21:07:42.455601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-05-08T21:07:42.45562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-05-08T21:07:42.455641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-05-08T21:07:42.456573Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T21:07:42.456619Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T21:07:42.456683Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T21:07:42.456754Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T21:07:42.457125Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T21:07:42.45716Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T21:07:42.458046Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T21:07:42.458168Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T21:07:42.458208Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T21:07:42.459957Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-08T21:07:42.46326Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} 2026/05/08 21:07:47 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-05-08T21:07:47.025717Z","caller":"traceutil/trace.go:171","msg":"trace[1393457128] linearizableReadLoop","detail":"{readStateIndex:236; appliedIndex:235; }","duration":"118.829176ms","start":"2026-05-08T21:07:46.906844Z","end":"2026-05-08T21:07:47.025673Z","steps":["trace[1393457128] 'read index received' (duration: 118.124213ms)","trace[1393457128] 'applied index is now lower than readState.Index' (duration: 703.283µs)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:07:47.026017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.659406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:07:47.026103Z","caller":"traceutil/trace.go:171","msg":"trace[694914610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:230; }","duration":"105.841644ms","start":"2026-05-08T21:07:46.920245Z","end":"2026-05-08T21:07:47.026087Z","steps":["trace[694914610] 'agreement among raft nodes before linearized reading' (duration: 105.673527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:07:47.026205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.240585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-08T21:07:47.0263Z","caller":"traceutil/trace.go:171","msg":"trace[1710393241] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:230; }","duration":"119.469997ms","start":"2026-05-08T21:07:46.906808Z","end":"2026-05-08T21:07:47.026278Z","steps":["trace[1710393241] 'agreement among raft nodes before linearized reading' (duration: 119.013735ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:07:56.534231Z","caller":"traceutil/trace.go:171","msg":"trace[1005561482] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"205.989513ms","start":"2026-05-08T21:07:56.328178Z","end":"2026-05-08T21:07:56.534168Z","steps":["trace[1005561482] 'process raft request' (duration: 205.664426ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:07:59.172266Z","caller":"traceutil/trace.go:171","msg":"trace[770310696] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"126.400977ms","start":"2026-05-08T21:07:59.045817Z","end":"2026-05-08T21:07:59.172218Z","steps":["trace[770310696] 'process raft request' (duration: 126.08446ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:07:59.496832Z","caller":"traceutil/trace.go:171","msg":"trace[503372111] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"109.058975ms","start":"2026-05-08T21:07:59.387741Z","end":"2026-05-08T21:07:59.4968Z","steps":["trace[503372111] 'process raft request' (duration: 94.606821ms)","trace[503372111] 'compare' (duration: 14.287205ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:07:59.49737Z","caller":"traceutil/trace.go:171","msg":"trace[2037103974] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:394; }","duration":"109.14929ms","start":"2026-05-08T21:07:59.388175Z","end":"2026-05-08T21:07:59.497325Z","steps":["trace[2037103974] 'read index received' (duration: 24.54078ms)","trace[2037103974] 'applied index is now lower than readState.Index' (duration: 84.60645ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:07:59.497813Z","caller":"traceutil/trace.go:171","msg":"trace[1832229043] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"109.710421ms","start":"2026-05-08T21:07:59.388079Z","end":"2026-05-08T21:07:59.497789Z","steps":["trace[1832229043] 'process raft request' (duration: 108.676084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:07:59.498938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.579208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-05-08T21:07:59.498997Z","caller":"traceutil/trace.go:171","msg":"trace[970558800] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:384; }","duration":"110.816722ms","start":"2026-05-08T21:07:59.388156Z","end":"2026-05-08T21:07:59.498972Z","steps":["trace[970558800] 'agreement among raft nodes before linearized reading' (duration: 109.295948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:07:59.75831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.112286ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:07:59.758665Z","caller":"traceutil/trace.go:171","msg":"trace[1107879614] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"231.22764ms","start":"2026-05-08T21:07:59.527411Z","end":"2026-05-08T21:07:59.758639Z","steps":["trace[1107879614] 'process raft request' (duration: 231.0396ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:07:59.758664Z","caller":"traceutil/trace.go:171","msg":"trace[67750691] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"233.871906ms","start":"2026-05-08T21:07:59.524693Z","end":"2026-05-08T21:07:59.758564Z","steps":["trace[67750691] 'process raft request' (duration: 75.844749ms)","trace[67750691] 'compare' (duration: 156.950867ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:07:59.791563Z","caller":"traceutil/trace.go:171","msg":"trace[232589956] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:402; }","duration":"151.097254ms","start":"2026-05-08T21:07:59.64045Z","end":"2026-05-08T21:07:59.791547Z","steps":["trace[232589956] 'read index received' (duration: 150.798928ms)","trace[232589956] 'applied index is now lower than readState.Index' (duration: 297.516µs)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:07:59.791678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.246343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T21:07:59.791715Z","caller":"traceutil/trace.go:171","msg":"trace[391439940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:393; }","duration":"151.324249ms","start":"2026-05-08T21:07:59.640381Z","end":"2026-05-08T21:07:59.791705Z","steps":["trace[391439940] 'agreement among raft nodes before linearized reading' (duration: 151.232823ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:07:59.791804Z","caller":"traceutil/trace.go:171","msg":"trace[1671557459] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"193.438904ms","start":"2026-05-08T21:07:59.598329Z","end":"2026-05-08T21:07:59.791768Z","steps":["trace[1671557459] 'process raft request' (duration: 193.074093ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:07:59.791807Z","caller":"traceutil/trace.go:171","msg":"trace[438629582] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"193.566121ms","start":"2026-05-08T21:07:59.598193Z","end":"2026-05-08T21:07:59.79176Z","steps":["trace[438629582] 'process raft request' (duration: 193.102585ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:07:59.792011Z","caller":"traceutil/trace.go:171","msg":"trace[1597236316] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"192.523673ms","start":"2026-05-08T21:07:59.599465Z","end":"2026-05-08T21:07:59.791989Z","steps":["trace[1597236316] 'process raft request' (duration: 191.981823ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:07:59.79209Z","caller":"traceutil/trace.go:171","msg":"trace[1472574024] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"193.843026ms","start":"2026-05-08T21:07:59.598234Z","end":"2026-05-08T21:07:59.792077Z","steps":["trace[1472574024] 'process raft request' (duration: 193.126756ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:13.294508Z","caller":"traceutil/trace.go:171","msg":"trace[106105693] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"116.47026ms","start":"2026-05-08T21:08:13.178002Z","end":"2026-05-08T21:08:13.294472Z","steps":["trace[106105693] 'process raft request' (duration: 116.388715ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:13.303488Z","caller":"traceutil/trace.go:171","msg":"trace[1832317225] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"125.421263ms","start":"2026-05-08T21:08:13.178057Z","end":"2026-05-08T21:08:13.303478Z","steps":["trace[1832317225] 'process raft request' (duration: 123.929932ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:13.30355Z","caller":"traceutil/trace.go:171","msg":"trace[1844608583] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"119.641224ms","start":"2026-05-08T21:08:13.183904Z","end":"2026-05-08T21:08:13.303545Z","steps":["trace[1844608583] 'process raft request' (duration: 119.225338ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:13.303587Z","caller":"traceutil/trace.go:171","msg":"trace[888993715] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"119.143693ms","start":"2026-05-08T21:08:13.18444Z","end":"2026-05-08T21:08:13.303583Z","steps":["trace[888993715] 'process raft request' (duration: 118.723177ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:13.303667Z","caller":"traceutil/trace.go:171","msg":"trace[1244652252] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"119.272452ms","start":"2026-05-08T21:08:13.18439Z","end":"2026-05-08T21:08:13.303662Z","steps":["trace[1244652252] 'process raft request' (duration: 118.791732ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:13.303712Z","caller":"traceutil/trace.go:171","msg":"trace[1318399247] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"119.199176ms","start":"2026-05-08T21:08:13.184509Z","end":"2026-05-08T21:08:13.303708Z","steps":["trace[1318399247] 'process raft request' (duration: 118.698875ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:13.30375Z","caller":"traceutil/trace.go:171","msg":"trace[2060284838] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"100.750929ms","start":"2026-05-08T21:08:13.202995Z","end":"2026-05-08T21:08:13.303746Z","steps":["trace[2060284838] 'process raft request' (duration: 100.240388ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:15.028165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.329168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:18056"} {"level":"info","ts":"2026-05-08T21:08:15.028257Z","caller":"traceutil/trace.go:171","msg":"trace[1911997341] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:544; }","duration":"353.466097ms","start":"2026-05-08T21:08:14.67477Z","end":"2026-05-08T21:08:15.028236Z","steps":["trace[1911997341] 'range keys from in-memory index tree' (duration: 353.150207ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:15.028302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:14.674753Z","time spent":"353.537091ms","remote":"127.0.0.1:43240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":18079,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-05-08T21:08:15.041179Z","caller":"traceutil/trace.go:171","msg":"trace[302697077] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"334.690648ms","start":"2026-05-08T21:08:14.70647Z","end":"2026-05-08T21:08:15.041161Z","steps":["trace[302697077] 'process raft request' (duration: 334.523877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:15.041443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:14.706435Z","time spent":"334.803215ms","remote":"127.0.0.1:43240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:08:15.041848Z","caller":"traceutil/trace.go:171","msg":"trace[91763933] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:563; }","duration":"318.784471ms","start":"2026-05-08T21:08:14.72302Z","end":"2026-05-08T21:08:15.041805Z","steps":["trace[91763933] 'read index received' (duration: 317.921858ms)","trace[91763933] 'applied index is now lower than readState.Index' (duration: 861.223µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:08:15.041939Z","caller":"traceutil/trace.go:171","msg":"trace[1141481497] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"320.0847ms","start":"2026-05-08T21:08:14.721814Z","end":"2026-05-08T21:08:15.041898Z","steps":["trace[1141481497] 'process raft request' (duration: 319.803153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:15.042077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:14.721796Z","time spent":"320.200477ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:08:15.042103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.056017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-08T21:08:15.042196Z","caller":"traceutil/trace.go:171","msg":"trace[278200566] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:546; }","duration":"319.189896ms","start":"2026-05-08T21:08:14.722976Z","end":"2026-05-08T21:08:15.042166Z","steps":["trace[278200566] 'agreement among raft nodes before linearized reading' (duration: 318.972522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:15.042232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:14.722956Z","time spent":"319.2691ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-08T21:08:19.600466Z","caller":"traceutil/trace.go:171","msg":"trace[113832374] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"317.767177ms","start":"2026-05-08T21:08:19.282661Z","end":"2026-05-08T21:08:19.600428Z","steps":["trace[113832374] 'process raft request' (duration: 317.542623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:19.600936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:19.282637Z","time spent":"318.013671ms","remote":"127.0.0.1:43402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:08:19.651864Z","caller":"traceutil/trace.go:171","msg":"trace[266687716] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"289.109442ms","start":"2026-05-08T21:08:19.362726Z","end":"2026-05-08T21:08:19.651835Z","steps":["trace[266687716] 'read index received' (duration: 238.037692ms)","trace[266687716] 'applied index is now lower than readState.Index' (duration: 51.07052ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:08:19.652036Z","caller":"traceutil/trace.go:171","msg":"trace[432728093] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"299.689871ms","start":"2026-05-08T21:08:19.352326Z","end":"2026-05-08T21:08:19.652016Z","steps":["trace[432728093] 'process raft request' (duration: 298.781804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:19.652265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.424693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:08:19.652357Z","caller":"traceutil/trace.go:171","msg":"trace[304903172] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"289.650596ms","start":"2026-05-08T21:08:19.362689Z","end":"2026-05-08T21:08:19.65234Z","steps":["trace[304903172] 'agreement among raft nodes before linearized reading' (duration: 289.368259ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:19.653045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.528831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-08T21:08:19.653099Z","caller":"traceutil/trace.go:171","msg":"trace[231379904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"220.627377ms","start":"2026-05-08T21:08:19.432458Z","end":"2026-05-08T21:08:19.653085Z","steps":["trace[231379904] 'agreement among raft nodes before linearized reading' (duration: 220.448906ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:20.352306Z","caller":"traceutil/trace.go:171","msg":"trace[1969142385] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"339.332187ms","start":"2026-05-08T21:08:20.012952Z","end":"2026-05-08T21:08:20.352284Z","steps":["trace[1969142385] 'read index received' (duration: 288.265183ms)","trace[1969142385] 'applied index is now lower than readState.Index' (duration: 51.065984ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:08:20.352442Z","caller":"traceutil/trace.go:171","msg":"trace[1509022917] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"640.043403ms","start":"2026-05-08T21:08:19.712345Z","end":"2026-05-08T21:08:20.352388Z","steps":["trace[1509022917] 'process raft request' (duration: 588.889104ms)","trace[1509022917] 'compare' (duration: 50.849351ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:08:20.352484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.532979ms","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-05-08T21:08:20.352562Z","caller":"traceutil/trace.go:171","msg":"trace[332456497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:578; }","duration":"339.615655ms","start":"2026-05-08T21:08:20.012889Z","end":"2026-05-08T21:08:20.352504Z","steps":["trace[332456497] 'agreement among raft nodes before linearized reading' (duration: 339.470886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:20.352575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:19.712306Z","time spent":"640.203473ms","remote":"127.0.0.1:43572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T21:08:20.352593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:20.012861Z","time spent":"339.722471ms","remote":"127.0.0.1:43486","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-05-08T21:08:21.540751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.454177ms","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-05-08T21:08:21.540872Z","caller":"traceutil/trace.go:171","msg":"trace[2018185988] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"122.606787ms","start":"2026-05-08T21:08:21.418247Z","end":"2026-05-08T21:08:21.540854Z","steps":["trace[2018185988] 'count revisions from in-memory index tree' (duration: 122.381282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:21.540976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.748886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:08:21.541076Z","caller":"traceutil/trace.go:171","msg":"trace[106410767] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"122.898385ms","start":"2026-05-08T21:08:21.418154Z","end":"2026-05-08T21:08:21.541052Z","steps":["trace[106410767] 'range keys from in-memory index tree' (duration: 122.639679ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:37.938426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.44209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:08:37.938538Z","caller":"traceutil/trace.go:171","msg":"trace[630011827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:742; }","duration":"573.598861ms","start":"2026-05-08T21:08:37.364922Z","end":"2026-05-08T21:08:37.938521Z","steps":["trace[630011827] 'range keys from in-memory index tree' (duration: 573.316701ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:37.938588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:37.364899Z","time spent":"573.670016ms","remote":"127.0.0.1:43166","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-05-08T21:08:37.938818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.681397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-08T21:08:37.938877Z","caller":"traceutil/trace.go:171","msg":"trace[1296391807] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:742; }","duration":"797.772843ms","start":"2026-05-08T21:08:37.141089Z","end":"2026-05-08T21:08:37.938862Z","steps":["trace[1296391807] 'range keys from in-memory index tree' (duration: 797.538188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:37.938908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:37.141068Z","time spent":"797.833797ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T21:08:37.939358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.542693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-08T21:08:37.939458Z","caller":"traceutil/trace.go:171","msg":"trace[168661106] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:742; }","duration":"774.668581ms","start":"2026-05-08T21:08:37.164761Z","end":"2026-05-08T21:08:37.93943Z","steps":["trace[168661106] 'range keys from in-memory index tree' (duration: 774.324859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:37.939509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:37.164751Z","time spent":"774.746466ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-08T21:08:37.94171Z","caller":"traceutil/trace.go:171","msg":"trace[1573893156] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:767; }","duration":"195.301621ms","start":"2026-05-08T21:08:37.746392Z","end":"2026-05-08T21:08:37.941694Z","steps":["trace[1573893156] 'read index received' (duration: 195.075777ms)","trace[1573893156] 'applied index is now lower than readState.Index' (duration: 225.084µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:08:37.941783Z","caller":"traceutil/trace.go:171","msg":"trace[1397983590] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"517.172356ms","start":"2026-05-08T21:08:37.424581Z","end":"2026-05-08T21:08:37.941753Z","steps":["trace[1397983590] 'process raft request' (duration: 516.92976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:37.941897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:37.42456Z","time spent":"517.262992ms","remote":"127.0.0.1:43460","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-05-08T21:08:37.94191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.874114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-08T21:08:37.941946Z","caller":"traceutil/trace.go:171","msg":"trace[1040943882] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:743; }","duration":"119.96379ms","start":"2026-05-08T21:08:37.821971Z","end":"2026-05-08T21:08:37.941935Z","steps":["trace[1040943882] 'agreement among raft nodes before linearized reading' (duration: 119.842552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:37.94201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.59712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-08T21:08:37.942095Z","caller":"traceutil/trace.go:171","msg":"trace[1479308443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:743; }","duration":"195.719078ms","start":"2026-05-08T21:08:37.746354Z","end":"2026-05-08T21:08:37.942073Z","steps":["trace[1479308443] 'agreement among raft nodes before linearized reading' (duration: 195.414388ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:42.526382Z","caller":"traceutil/trace.go:171","msg":"trace[318350697] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:828; }","duration":"103.047156ms","start":"2026-05-08T21:08:42.42331Z","end":"2026-05-08T21:08:42.526357Z","steps":["trace[318350697] 'read index received' (duration: 102.869455ms)","trace[318350697] 'applied index is now lower than readState.Index' (duration: 176.551µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:08:42.526895Z","caller":"traceutil/trace.go:171","msg":"trace[501215059] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"112.577019ms","start":"2026-05-08T21:08:42.41429Z","end":"2026-05-08T21:08:42.526867Z","steps":["trace[501215059] 'process raft request' (duration: 111.917546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:42.52731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.982069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:08:42.52736Z","caller":"traceutil/trace.go:171","msg":"trace[711168017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"104.061134ms","start":"2026-05-08T21:08:42.423285Z","end":"2026-05-08T21:08:42.527346Z","steps":["trace[711168017] 'agreement among raft nodes before linearized reading' (duration: 103.970619ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:42.749996Z","caller":"traceutil/trace.go:171","msg":"trace[89957073] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:829; }","duration":"195.577562ms","start":"2026-05-08T21:08:42.554402Z","end":"2026-05-08T21:08:42.74998Z","steps":["trace[89957073] 'read index received' (duration: 178.350896ms)","trace[89957073] 'applied index is now lower than readState.Index' (duration: 17.226106ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:08:42.750042Z","caller":"traceutil/trace.go:171","msg":"trace[1522829588] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"216.58425ms","start":"2026-05-08T21:08:42.533421Z","end":"2026-05-08T21:08:42.750005Z","steps":["trace[1522829588] 'process raft request' (duration: 216.43714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:42.750129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.70283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:08:42.750167Z","caller":"traceutil/trace.go:171","msg":"trace[1370375685] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:0; response_revision:806; }","duration":"195.769315ms","start":"2026-05-08T21:08:42.554384Z","end":"2026-05-08T21:08:42.750154Z","steps":["trace[1370375685] 'agreement among raft nodes before linearized reading' (duration: 195.670028ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:42.751378Z","caller":"traceutil/trace.go:171","msg":"trace[399898117] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"215.934087ms","start":"2026-05-08T21:08:42.534261Z","end":"2026-05-08T21:08:42.750196Z","steps":["trace[399898117] 'process raft request' (duration: 215.672019ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:42.749742Z","caller":"traceutil/trace.go:171","msg":"trace[62151408] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"218.190186ms","start":"2026-05-08T21:08:42.531526Z","end":"2026-05-08T21:08:42.749717Z","steps":["trace[62151408] 'process raft request' (duration: 201.058366ms)","trace[62151408] 'compare' (duration: 16.84143ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:08:44.121947Z","caller":"traceutil/trace.go:171","msg":"trace[667355793] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:839; }","duration":"135.081769ms","start":"2026-05-08T21:08:43.986841Z","end":"2026-05-08T21:08:44.121923Z","steps":["trace[667355793] 'read index received' (duration: 134.879094ms)","trace[667355793] 'applied index is now lower than readState.Index' (duration: 201.275µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:08:44.122042Z","caller":"traceutil/trace.go:171","msg":"trace[1845126692] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"140.364831ms","start":"2026-05-08T21:08:43.981654Z","end":"2026-05-08T21:08:44.122019Z","steps":["trace[1845126692] 'process raft request' (duration: 140.127816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:44.122142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.280462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-08T21:08:44.122196Z","caller":"traceutil/trace.go:171","msg":"trace[1448736308] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:814; }","duration":"135.382349ms","start":"2026-05-08T21:08:43.986799Z","end":"2026-05-08T21:08:44.122181Z","steps":["trace[1448736308] 'agreement among raft nodes before linearized reading' (duration: 135.234089ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:44.720018Z","caller":"traceutil/trace.go:171","msg":"trace[767819018] linearizableReadLoop","detail":"{readStateIndex:842; appliedIndex:841; }","duration":"242.837626ms","start":"2026-05-08T21:08:44.477159Z","end":"2026-05-08T21:08:44.719997Z","steps":["trace[767819018] 'read index received' (duration: 242.709337ms)","trace[767819018] 'applied index is now lower than readState.Index' (duration: 127.319µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:08:44.720088Z","caller":"traceutil/trace.go:171","msg":"trace[236594340] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"308.210791ms","start":"2026-05-08T21:08:44.411842Z","end":"2026-05-08T21:08:44.720053Z","steps":["trace[236594340] 'process raft request' (duration: 308.036459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:08:44.720198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.984226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-08T21:08:44.720252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:08:44.411825Z","time spent":"308.335249ms","remote":"127.0.0.1:43396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4794,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:08:44.72024Z","caller":"traceutil/trace.go:171","msg":"trace[495866309] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:816; }","duration":"243.150666ms","start":"2026-05-08T21:08:44.477079Z","end":"2026-05-08T21:08:44.720229Z","steps":["trace[495866309] 'agreement among raft nodes before linearized reading' (duration: 243.003417ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:08:51.957044Z","caller":"traceutil/trace.go:171","msg":"trace[1911563507] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"124.28699ms","start":"2026-05-08T21:08:51.832719Z","end":"2026-05-08T21:08:51.957006Z","steps":["trace[1911563507] 'process raft request' (duration: 124.123199ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:09:00.169157Z","caller":"traceutil/trace.go:171","msg":"trace[2022365295] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"103.715332ms","start":"2026-05-08T21:09:00.065409Z","end":"2026-05-08T21:09:00.169125Z","steps":["trace[2022365295] 'process raft request' (duration: 81.58703ms)","trace[2022365295] 'compare' (duration: 21.984258ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:09:07.278279Z","caller":"traceutil/trace.go:171","msg":"trace[1679565311] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"402.809869ms","start":"2026-05-08T21:09:06.875441Z","end":"2026-05-08T21:09:07.278251Z","steps":["trace[1679565311] 'process raft request' (duration: 402.631203ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:09:07.278465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:09:06.875424Z","time spent":"402.948226ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:09:07.352978Z","caller":"traceutil/trace.go:171","msg":"trace[751953110] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"424.355165ms","start":"2026-05-08T21:09:06.928598Z","end":"2026-05-08T21:09:07.352953Z","steps":["trace[751953110] 'process raft request' (duration: 423.559066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:09:07.353123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:09:06.928577Z","time spent":"424.471672ms","remote":"127.0.0.1:43486","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-05-08T21:09:56.01435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.330812ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-05-08T21:09:56.014535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:09:55.569387Z","time spent":"445.140422ms","remote":"127.0.0.1:43214","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-08T21:09:56.014661Z","caller":"traceutil/trace.go:171","msg":"trace[690547215] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"245.52581ms","start":"2026-05-08T21:09:55.769117Z","end":"2026-05-08T21:09:56.014643Z","steps":["trace[690547215] 'process raft request' (duration: 245.484549ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:09:56.014736Z","caller":"traceutil/trace.go:171","msg":"trace[434060351] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"442.343872ms","start":"2026-05-08T21:09:55.572361Z","end":"2026-05-08T21:09:56.014705Z","steps":["trace[434060351] 'process raft request' (duration: 442.096968ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:09:56.014768Z","caller":"traceutil/trace.go:171","msg":"trace[864335786] linearizableReadLoop","detail":"{readStateIndex:1894; appliedIndex:1892; }","duration":"354.520341ms","start":"2026-05-08T21:09:55.660212Z","end":"2026-05-08T21:09:56.014732Z","steps":["trace[864335786] 'read index received' (duration: 35.801671ms)","trace[864335786] 'applied index is now lower than readState.Index' (duration: 318.7164ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:09:56.014896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:09:55.572329Z","time spent":"442.478905ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:09:56.015016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.739755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-08T21:09:56.015056Z","caller":"traceutil/trace.go:171","msg":"trace[750791426] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1826; }","duration":"354.864227ms","start":"2026-05-08T21:09:55.660177Z","end":"2026-05-08T21:09:56.015042Z","steps":["trace[750791426] 'agreement among raft nodes before linearized reading' (duration: 354.659424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:09:56.015088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:09:55.660162Z","time spent":"354.917979ms","remote":"127.0.0.1:44210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-08T21:09:56.015083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.148745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9026fdb1-8bab-4ef0-a4dc-bbff1337a0fa\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-05-08T21:09:56.01509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.876324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9026fdb1-8bab-4ef0-a4dc-bbff1337a0fa\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-08T21:09:56.015123Z","caller":"traceutil/trace.go:171","msg":"trace[1646344165] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9026fdb1-8bab-4ef0-a4dc-bbff1337a0fa; range_end:; response_count:1; response_revision:1826; }","duration":"244.225377ms","start":"2026-05-08T21:09:55.770887Z","end":"2026-05-08T21:09:56.015112Z","steps":["trace[1646344165] 'agreement among raft nodes before linearized reading' (duration: 244.085474ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:09:56.015139Z","caller":"traceutil/trace.go:171","msg":"trace[660126000] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9026fdb1-8bab-4ef0-a4dc-bbff1337a0fa; range_end:; response_count:1; response_revision:1826; }","duration":"208.946565ms","start":"2026-05-08T21:09:55.806179Z","end":"2026-05-08T21:09:56.015125Z","steps":["trace[660126000] 'agreement among raft nodes before linearized reading' (duration: 208.809462ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:09:56.465897Z","caller":"traceutil/trace.go:171","msg":"trace[1086596484] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"449.540724ms","start":"2026-05-08T21:09:56.016303Z","end":"2026-05-08T21:09:56.465844Z","steps":["trace[1086596484] 'process raft request' (duration: 419.983246ms)","trace[1086596484] 'compare' (duration: 29.290963ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:09:56.466072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:09:56.016284Z","time spent":"449.698327ms","remote":"127.0.0.1:43214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:09:56.469391Z","caller":"traceutil/trace.go:171","msg":"trace[913362153] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"446.183761ms","start":"2026-05-08T21:09:56.023189Z","end":"2026-05-08T21:09:56.469373Z","steps":["trace[913362153] 'process raft request' (duration: 446.065529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:09:56.469501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:09:56.02318Z","time spent":"446.259923ms","remote":"127.0.0.1:43402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:09:56.469614Z","caller":"traceutil/trace.go:171","msg":"trace[2103701987] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"387.575327ms","start":"2026-05-08T21:09:56.082033Z","end":"2026-05-08T21:09:56.469608Z","steps":["trace[2103701987] 'process raft request' (duration: 387.305491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:09:56.469641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:09:56.08201Z","time spent":"387.615478ms","remote":"127.0.0.1:43486","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-05-08T21:09:56.469896Z","caller":"traceutil/trace.go:171","msg":"trace[828376803] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"267.223438ms","start":"2026-05-08T21:09:56.202667Z","end":"2026-05-08T21:09:56.469891Z","steps":["trace[828376803] 'process raft request' (duration: 266.913122ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:09:56.470035Z","caller":"traceutil/trace.go:171","msg":"trace[125133440] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"181.795176ms","start":"2026-05-08T21:09:56.288235Z","end":"2026-05-08T21:09:56.47003Z","steps":["trace[125133440] 'process raft request' (duration: 181.590692ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:07.647207Z","caller":"traceutil/trace.go:171","msg":"trace[399159409] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"164.012841ms","start":"2026-05-08T21:10:07.483173Z","end":"2026-05-08T21:10:07.647186Z","steps":["trace[399159409] 'process raft request' (duration: 163.877668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:11.616456Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439931077336493,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T21:10:12.117837Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439931077336493,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T21:10:12.143353Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.118951328s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T21:10:12.143846Z","caller":"traceutil/trace.go:171","msg":"trace[727141419] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"1.119579655s","start":"2026-05-08T21:10:11.024241Z","end":"2026-05-08T21:10:12.14382Z","steps":["trace[727141419] 'process raft request' (duration: 1.11937961s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:12.144008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:11.024218Z","time spent":"1.119707598s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:10:12.194609Z","caller":"traceutil/trace.go:171","msg":"trace[1967865146] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"492.91034ms","start":"2026-05-08T21:10:11.701658Z","end":"2026-05-08T21:10:12.194568Z","steps":["trace[1967865146] 'process raft request' (duration: 492.724784ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:12.194571Z","caller":"traceutil/trace.go:171","msg":"trace[1222346915] linearizableReadLoop","detail":"{readStateIndex:2033; appliedIndex:2030; }","duration":"1.079033377s","start":"2026-05-08T21:10:11.115516Z","end":"2026-05-08T21:10:12.194549Z","steps":["trace[1222346915] 'read index received' (duration: 1.028077782s)","trace[1222346915] 'applied index is now lower than readState.Index' (duration: 50.934165ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:10:12.194806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:11.701629Z","time spent":"493.040624ms","remote":"127.0.0.1:43486","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-05-08T21:10:12.194832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.337748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:10:12.194854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079332665s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-08T21:10:12.194871Z","caller":"traceutil/trace.go:171","msg":"trace[643089330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1960; }","duration":"830.424781ms","start":"2026-05-08T21:10:11.364433Z","end":"2026-05-08T21:10:12.194858Z","steps":["trace[643089330] 'agreement among raft nodes before linearized reading' (duration: 830.334178ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:12.19491Z","caller":"traceutil/trace.go:171","msg":"trace[2042206596] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1960; }","duration":"1.079429508s","start":"2026-05-08T21:10:11.115463Z","end":"2026-05-08T21:10:12.194893Z","steps":["trace[2042206596] 'agreement among raft nodes before linearized reading' (duration: 1.079236112s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:12.194912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:11.364416Z","time spent":"830.488502ms","remote":"127.0.0.1:43166","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-05-08T21:10:12.194946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:11.115442Z","time spent":"1.07949591s","remote":"127.0.0.1:44210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-08T21:10:28.893257Z","caller":"traceutil/trace.go:171","msg":"trace[1387023613] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"272.897683ms","start":"2026-05-08T21:10:28.620338Z","end":"2026-05-08T21:10:28.893236Z","steps":["trace[1387023613] 'process raft request' (duration: 272.822881ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:28.893234Z","caller":"traceutil/trace.go:171","msg":"trace[768310261] linearizableReadLoop","detail":"{readStateIndex:2134; appliedIndex:2131; }","duration":"255.044897ms","start":"2026-05-08T21:10:28.638165Z","end":"2026-05-08T21:10:28.89321Z","steps":["trace[768310261] 'read index received' (duration: 39.105246ms)","trace[768310261] 'applied index is now lower than readState.Index' (duration: 215.938561ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:10:28.893233Z","caller":"traceutil/trace.go:171","msg":"trace[237027867] transaction","detail":"{read_only:false; response_revision:2057; number_of_response:1; }","duration":"295.516769ms","start":"2026-05-08T21:10:28.597689Z","end":"2026-05-08T21:10:28.893205Z","steps":["trace[237027867] 'process raft request' (duration: 290.559591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:28.893492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.092146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-08T21:10:28.893525Z","caller":"traceutil/trace.go:171","msg":"trace[1119481298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2058; }","duration":"249.139367ms","start":"2026-05-08T21:10:28.644374Z","end":"2026-05-08T21:10:28.893514Z","steps":["trace[1119481298] 'agreement among raft nodes before linearized reading' (duration: 248.995323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:28.893636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.456911ms","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-05-08T21:10:28.893753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.471079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-08T21:10:28.893871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.580486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-08T21:10:28.893905Z","caller":"traceutil/trace.go:171","msg":"trace[1677777606] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2058; }","duration":"245.648788ms","start":"2026-05-08T21:10:28.648244Z","end":"2026-05-08T21:10:28.893893Z","steps":["trace[1677777606] 'agreement among raft nodes before linearized reading' (duration: 245.545685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:28.89364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.671233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12380"} {"level":"info","ts":"2026-05-08T21:10:28.893871Z","caller":"traceutil/trace.go:171","msg":"trace[1847553394] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2058; }","duration":"255.71199ms","start":"2026-05-08T21:10:28.638052Z","end":"2026-05-08T21:10:28.893764Z","steps":["trace[1847553394] 'agreement among raft nodes before linearized reading' (duration: 255.187972ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:28.89404Z","caller":"traceutil/trace.go:171","msg":"trace[1955871989] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2058; }","duration":"216.539921ms","start":"2026-05-08T21:10:28.677247Z","end":"2026-05-08T21:10:28.893787Z","steps":["trace[1955871989] 'agreement among raft nodes before linearized reading' (duration: 216.427178ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:28.893984Z","caller":"traceutil/trace.go:171","msg":"trace[396550502] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2058; }","duration":"175.060406ms","start":"2026-05-08T21:10:28.718911Z","end":"2026-05-08T21:10:28.893971Z","steps":["trace[396550502] 'agreement among raft nodes before linearized reading' (duration: 174.499297ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:35.458175Z","caller":"traceutil/trace.go:171","msg":"trace[83335143] linearizableReadLoop","detail":"{readStateIndex:2166; appliedIndex:2164; }","duration":"539.908741ms","start":"2026-05-08T21:10:34.918234Z","end":"2026-05-08T21:10:35.458143Z","steps":["trace[83335143] 'read index received' (duration: 37.404167ms)","trace[83335143] 'applied index is now lower than readState.Index' (duration: 502.503114ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:10:35.458322Z","caller":"traceutil/trace.go:171","msg":"trace[1206013931] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"545.586596ms","start":"2026-05-08T21:10:34.912719Z","end":"2026-05-08T21:10:35.458306Z","steps":["trace[1206013931] 'process raft request' (duration: 544.918451ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:35.458456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:34.912706Z","time spent":"545.658499ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:10:35.45887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.630807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-08T21:10:35.458942Z","caller":"traceutil/trace.go:171","msg":"trace[1525170232] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2089; }","duration":"540.742701ms","start":"2026-05-08T21:10:34.918183Z","end":"2026-05-08T21:10:35.458926Z","steps":["trace[1525170232] 'agreement among raft nodes before linearized reading' (duration: 540.614596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:35.458976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:34.918163Z","time spent":"540.805323ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T21:10:35.459246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.13983ms","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-05-08T21:10:35.459249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.083232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-08T21:10:35.459293Z","caller":"traceutil/trace.go:171","msg":"trace[1801035865] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2089; }","duration":"540.958449ms","start":"2026-05-08T21:10:34.918323Z","end":"2026-05-08T21:10:35.459282Z","steps":["trace[1801035865] 'agreement among raft nodes before linearized reading' (duration: 540.060417ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:35.459305Z","caller":"traceutil/trace.go:171","msg":"trace[766286041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2089; }","duration":"539.170095ms","start":"2026-05-08T21:10:34.920119Z","end":"2026-05-08T21:10:35.459289Z","steps":["trace[766286041] 'agreement among raft nodes before linearized reading' (duration: 539.016899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:35.459323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:34.918317Z","time spent":"540.998701ms","remote":"127.0.0.1:43486","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-05-08T21:10:35.459357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:34.920107Z","time spent":"539.229416ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T21:10:35.459236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.311103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-08T21:10:35.459463Z","caller":"traceutil/trace.go:171","msg":"trace[318179374] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2089; }","duration":"533.570084ms","start":"2026-05-08T21:10:34.925883Z","end":"2026-05-08T21:10:35.459453Z","steps":["trace[318179374] 'agreement among raft nodes before linearized reading' (duration: 533.243891ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:35.459495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:34.925871Z","time spent":"533.614486ms","remote":"127.0.0.1:43486","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-05-08T21:10:35.675451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.464212ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:10:35.675736Z","caller":"traceutil/trace.go:171","msg":"trace[1640140811] linearizableReadLoop","detail":"{readStateIndex:2170; appliedIndex:2166; }","duration":"155.298306ms","start":"2026-05-08T21:10:35.520419Z","end":"2026-05-08T21:10:35.675717Z","steps":["trace[1640140811] 'read index received' (duration: 8.556891ms)","trace[1640140811] 'applied index is now lower than readState.Index' (duration: 146.740275ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:10:35.675885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.457192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-08T21:10:35.675837Z","caller":"traceutil/trace.go:171","msg":"trace[1904953779] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"211.587923ms","start":"2026-05-08T21:10:35.46421Z","end":"2026-05-08T21:10:35.675798Z","steps":["trace[1904953779] 'process raft request' (duration: 211.377525ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:35.675933Z","caller":"traceutil/trace.go:171","msg":"trace[1084779070] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:2093; }","duration":"155.546185ms","start":"2026-05-08T21:10:35.520375Z","end":"2026-05-08T21:10:35.675921Z","steps":["trace[1084779070] 'agreement among raft nodes before linearized reading' (duration: 155.40739ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:35.676087Z","caller":"traceutil/trace.go:171","msg":"trace[153739789] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"212.134342ms","start":"2026-05-08T21:10:35.46391Z","end":"2026-05-08T21:10:35.676044Z","steps":["trace[153739789] 'process raft request' (duration: 107.984786ms)","trace[153739789] 'compare' (duration: 103.316437ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:10:35.676165Z","caller":"traceutil/trace.go:171","msg":"trace[73875085] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"210.797103ms","start":"2026-05-08T21:10:35.465351Z","end":"2026-05-08T21:10:35.676148Z","steps":["trace[73875085] 'process raft request' (duration: 210.324556ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:35.86928Z","caller":"traceutil/trace.go:171","msg":"trace[556227586] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"129.705705ms","start":"2026-05-08T21:10:35.73954Z","end":"2026-05-08T21:10:35.869245Z","steps":["trace[556227586] 'process raft request' (duration: 42.745503ms)","trace[556227586] 'compare' (duration: 86.098461ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:10:36.897204Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439931077336821,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T21:10:37.390873Z","caller":"traceutil/trace.go:171","msg":"trace[19933519] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"1.086597399s","start":"2026-05-08T21:10:36.304253Z","end":"2026-05-08T21:10:37.39085Z","steps":["trace[19933519] 'process raft request' (duration: 1.086446623s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:37.391025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:36.304227Z","time spent":"1.086717543s","remote":"127.0.0.1:43486","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-05-08T21:10:38.136823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.371859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:10:38.137275Z","caller":"traceutil/trace.go:171","msg":"trace[1696693431] linearizableReadLoop","detail":"{readStateIndex:2174; appliedIndex:2172; }","duration":"1.740494011s","start":"2026-05-08T21:10:36.396762Z","end":"2026-05-08T21:10:38.137256Z","steps":["trace[1696693431] 'read index received' (duration: 994.004282ms)","trace[1696693431] 'applied index is now lower than readState.Index' (duration: 746.488689ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:10:38.137358Z","caller":"traceutil/trace.go:171","msg":"trace[1855206237] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"1.172069278s","start":"2026-05-08T21:10:36.965279Z","end":"2026-05-08T21:10:38.137349Z","steps":["trace[1855206237] 'process raft request' (duration: 1.171821078s)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:38.137411Z","caller":"traceutil/trace.go:171","msg":"trace[878101736] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"1.420391457s","start":"2026-05-08T21:10:36.716995Z","end":"2026-05-08T21:10:38.137386Z","steps":["trace[878101736] 'process raft request' (duration: 898.324253ms)","trace[878101736] 'compare' (duration: 521.045696ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:10:38.137436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:36.965257Z","time spent":"1.17212475s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:10:38.137478Z","caller":"traceutil/trace.go:171","msg":"trace[1087194532] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"673.296431ms","start":"2026-05-08T21:10:37.464153Z","end":"2026-05-08T21:10:38.137449Z","steps":["trace[1087194532] 'process raft request' (duration: 673.062623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.137539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:36.716956Z","time spent":"1.420511492s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:10:38.137702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:37.464075Z","time spent":"673.492289ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:10:38.137696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.740908106s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T21:10:38.137817Z","caller":"traceutil/trace.go:171","msg":"trace[1167791392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2098; }","duration":"1.741086253s","start":"2026-05-08T21:10:36.396715Z","end":"2026-05-08T21:10:38.137801Z","steps":["trace[1167791392] 'agreement among raft nodes before linearized reading' (duration: 1.740644667s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.137863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:36.396697Z","time spent":"1.741152646s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-08T21:10:38.163666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.301667ms","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":"warn","ts":"2026-05-08T21:10:38.163786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.464963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-08T21:10:38.163651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.696253406s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-08T21:10:38.163914Z","caller":"traceutil/trace.go:171","msg":"trace[224304772] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2099; }","duration":"1.696594808s","start":"2026-05-08T21:10:36.467303Z","end":"2026-05-08T21:10:38.163898Z","steps":["trace[224304772] 'agreement among raft nodes before linearized reading' (duration: 1.6961141s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.163965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.999844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T21:10:38.164004Z","caller":"traceutil/trace.go:171","msg":"trace[94934380] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2099; }","duration":"631.065047ms","start":"2026-05-08T21:10:37.532929Z","end":"2026-05-08T21:10:38.163994Z","steps":["trace[94934380] 'agreement among raft nodes before linearized reading' (duration: 630.957143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.164047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:37.532916Z","time spent":"631.121899ms","remote":"127.0.0.1:43486","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-05-08T21:10:38.164056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:36.467281Z","time spent":"1.696708722s","remote":"127.0.0.1:44210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-08T21:10:38.164355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.253424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:10:38.164391Z","caller":"traceutil/trace.go:171","msg":"trace[2113174284] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2099; }","duration":"711.330947ms","start":"2026-05-08T21:10:37.453051Z","end":"2026-05-08T21:10:38.164382Z","steps":["trace[2113174284] 'agreement among raft nodes before linearized reading' (duration: 711.269255ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.164434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:37.453033Z","time spent":"711.39439ms","remote":"127.0.0.1:43472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:10:38.164612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.27123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:10:38.164645Z","caller":"traceutil/trace.go:171","msg":"trace[569314131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2099; }","duration":"800.342692ms","start":"2026-05-08T21:10:37.364294Z","end":"2026-05-08T21:10:38.164637Z","steps":["trace[569314131] 'agreement among raft nodes before linearized reading' (duration: 800.29162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.164674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:37.364253Z","time spent":"800.412635ms","remote":"127.0.0.1:43166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T21:10:38.163801Z","caller":"traceutil/trace.go:171","msg":"trace[1597282207] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2099; }","duration":"483.459544ms","start":"2026-05-08T21:10:37.680326Z","end":"2026-05-08T21:10:38.163785Z","steps":["trace[1597282207] 'agreement among raft nodes before linearized reading' (duration: 483.269787ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.165165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:37.680243Z","time spent":"484.903137ms","remote":"127.0.0.1:35686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:10:38.16538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.897637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-08T21:10:38.165419Z","caller":"traceutil/trace.go:171","msg":"trace[1747708951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2099; }","duration":"484.98444ms","start":"2026-05-08T21:10:37.680423Z","end":"2026-05-08T21:10:38.165407Z","steps":["trace[1747708951] 'agreement among raft nodes before linearized reading' (duration: 484.886426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.165446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:37.680393Z","time spent":"485.046892ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T21:10:38.165642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.222859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-08T21:10:38.165678Z","caller":"traceutil/trace.go:171","msg":"trace[438963916] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2099; }","duration":"485.307702ms","start":"2026-05-08T21:10:37.680362Z","end":"2026-05-08T21:10:38.16567Z","steps":["trace[438963916] 'agreement among raft nodes before linearized reading' (duration: 485.216879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.165706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:37.680341Z","time spent":"485.358624ms","remote":"127.0.0.1:43486","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":"info","ts":"2026-05-08T21:10:38.163858Z","caller":"traceutil/trace.go:171","msg":"trace[1935403185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2099; }","duration":"483.562357ms","start":"2026-05-08T21:10:37.68027Z","end":"2026-05-08T21:10:38.163833Z","steps":["trace[1935403185] 'agreement among raft nodes before linearized reading' (duration: 483.450823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.165851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:37.680243Z","time spent":"485.601163ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T21:10:38.667224Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439931077336829,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T21:10:38.834143Z","caller":"traceutil/trace.go:171","msg":"trace[1748042217] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"661.897037ms","start":"2026-05-08T21:10:38.172211Z","end":"2026-05-08T21:10:38.834108Z","steps":["trace[1748042217] 'process raft request' (duration: 661.734021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.834336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:38.172198Z","time spent":"662.036613ms","remote":"127.0.0.1:43486","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-05-08T21:10:38.83415Z","caller":"traceutil/trace.go:171","msg":"trace[1188503980] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"690.060718ms","start":"2026-05-08T21:10:38.144028Z","end":"2026-05-08T21:10:38.834089Z","steps":["trace[1188503980] 'process raft request' (duration: 681.389075ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:38.835174Z","caller":"traceutil/trace.go:171","msg":"trace[210988825] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"662.768539ms","start":"2026-05-08T21:10:38.172323Z","end":"2026-05-08T21:10:38.835092Z","steps":["trace[210988825] 'process raft request' (duration: 661.742832ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:10:38.835324Z","caller":"traceutil/trace.go:171","msg":"trace[1153352975] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"662.944256ms","start":"2026-05-08T21:10:38.172366Z","end":"2026-05-08T21:10:38.83531Z","steps":["trace[1153352975] 'process raft request' (duration: 662.576212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.835409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:38.172361Z","time spent":"663.008299ms","remote":"127.0.0.1:43486","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-05-08T21:10:38.835407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:38.172313Z","time spent":"662.956187ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:10:38.835438Z","caller":"traceutil/trace.go:171","msg":"trace[1608490738] linearizableReadLoop","detail":"{readStateIndex:2182; appliedIndex:2177; }","duration":"669.19941ms","start":"2026-05-08T21:10:38.166215Z","end":"2026-05-08T21:10:38.835414Z","steps":["trace[1608490738] 'read index received' (duration: 659.143515ms)","trace[1608490738] 'applied index is now lower than readState.Index' (duration: 10.054895ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:10:38.835501Z","caller":"traceutil/trace.go:171","msg":"trace[1866770393] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"663.126914ms","start":"2026-05-08T21:10:38.172364Z","end":"2026-05-08T21:10:38.835491Z","steps":["trace[1866770393] 'process raft request' (duration: 662.895625ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.835612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.366416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:10:38.835555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:38.172343Z","time spent":"663.182265ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:10:38.83566Z","caller":"traceutil/trace.go:171","msg":"trace[503213725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2104; }","duration":"669.479329ms","start":"2026-05-08T21:10:38.166168Z","end":"2026-05-08T21:10:38.835647Z","steps":["trace[503213725] 'agreement among raft nodes before linearized reading' (duration: 669.369195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.835699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:38.16615Z","time spent":"669.540362ms","remote":"127.0.0.1:43178","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-05-08T21:10:38.835748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.454569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18adb35914f9edde\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-05-08T21:10:38.835816Z","caller":"traceutil/trace.go:171","msg":"trace[1508233084] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18adb35914f9edde; range_end:; response_count:1; response_revision:2104; }","duration":"654.557863ms","start":"2026-05-08T21:10:38.181237Z","end":"2026-05-08T21:10:38.835795Z","steps":["trace[1508233084] 'agreement among raft nodes before linearized reading' (duration: 654.358966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:10:38.835873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:38.181228Z","time spent":"654.634136ms","remote":"127.0.0.1:43274","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.18adb35914f9edde\" "} {"level":"warn","ts":"2026-05-08T21:10:38.836674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:10:38.14401Z","time spent":"690.989693ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:11:25.240155Z","caller":"traceutil/trace.go:171","msg":"trace[707555393] transaction","detail":"{read_only:false; response_revision:2456; number_of_response:1; }","duration":"137.010322ms","start":"2026-05-08T21:11:25.103119Z","end":"2026-05-08T21:11:25.240129Z","steps":["trace[707555393] 'process raft request' (duration: 136.890066ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:11:25.703515Z","caller":"traceutil/trace.go:171","msg":"trace[1395535817] transaction","detail":"{read_only:false; response_revision:2457; number_of_response:1; }","duration":"599.984192ms","start":"2026-05-08T21:11:25.103483Z","end":"2026-05-08T21:11:25.703468Z","steps":["trace[1395535817] 'process raft request' (duration: 553.287289ms)","trace[1395535817] 'compare' (duration: 46.22092ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:11:25.703573Z","caller":"traceutil/trace.go:171","msg":"trace[455544580] transaction","detail":"{read_only:false; response_revision:2458; number_of_response:1; }","duration":"599.688156ms","start":"2026-05-08T21:11:25.103856Z","end":"2026-05-08T21:11:25.703544Z","steps":["trace[455544580] 'process raft request' (duration: 599.406063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:11:25.703704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:25.103473Z","time spent":"600.119038ms","remote":"127.0.0.1:43486","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-05-08T21:11:25.703707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:25.103837Z","time spent":"599.793302ms","remote":"127.0.0.1:43486","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-05-08T21:11:25.703625Z","caller":"traceutil/trace.go:171","msg":"trace[1638399358] linearizableReadLoop","detail":"{readStateIndex:2547; appliedIndex:2545; }","duration":"593.940332ms","start":"2026-05-08T21:11:25.109656Z","end":"2026-05-08T21:11:25.703597Z","steps":["trace[1638399358] 'read index received' (duration: 130.833916ms)","trace[1638399358] 'applied index is now lower than readState.Index' (duration: 463.104226ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:11:25.704212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.55443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-08T21:11:25.704283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.987897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:11:25.704337Z","caller":"traceutil/trace.go:171","msg":"trace[2071833883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2459; }","duration":"340.063232ms","start":"2026-05-08T21:11:25.364259Z","end":"2026-05-08T21:11:25.704322Z","steps":["trace[2071833883] 'agreement among raft nodes before linearized reading' (duration: 340.005488ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:11:25.70429Z","caller":"traceutil/trace.go:171","msg":"trace[1625848795] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2459; }","duration":"594.632555ms","start":"2026-05-08T21:11:25.109643Z","end":"2026-05-08T21:11:25.704276Z","steps":["trace[1625848795] 'agreement among raft nodes before linearized reading' (duration: 594.269868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:11:25.704374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:25.364242Z","time spent":"340.125214ms","remote":"127.0.0.1:43166","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-05-08T21:11:25.704359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.075982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-05-08T21:11:25.704404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.670927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-08T21:11:25.70449Z","caller":"traceutil/trace.go:171","msg":"trace[1458788082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2459; }","duration":"594.799203ms","start":"2026-05-08T21:11:25.109649Z","end":"2026-05-08T21:11:25.704448Z","steps":["trace[1458788082] 'agreement among raft nodes before linearized reading' (duration: 594.429075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:11:25.704455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:25.109626Z","time spent":"594.816884ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-08T21:11:25.704483Z","caller":"traceutil/trace.go:171","msg":"trace[1202491189] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2459; }","duration":"299.201488ms","start":"2026-05-08T21:11:25.405215Z","end":"2026-05-08T21:11:25.704416Z","steps":["trace[1202491189] 'agreement among raft nodes before linearized reading' (duration: 298.986006ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:11:25.704221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.31421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-08T21:11:25.704824Z","caller":"traceutil/trace.go:171","msg":"trace[1206654619] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:2459; }","duration":"181.94171ms","start":"2026-05-08T21:11:25.522856Z","end":"2026-05-08T21:11:25.704798Z","steps":["trace[1206654619] 'agreement among raft nodes before linearized reading' (duration: 181.247217ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:11:25.70456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:25.109631Z","time spent":"594.893718ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-08T21:11:59.584077Z","caller":"traceutil/trace.go:171","msg":"trace[2062607937] linearizableReadLoop","detail":"{readStateIndex:2741; appliedIndex:2740; }","duration":"276.137351ms","start":"2026-05-08T21:11:59.307911Z","end":"2026-05-08T21:11:59.584049Z","steps":["trace[2062607937] 'read index received' (duration: 275.968642ms)","trace[2062607937] 'applied index is now lower than readState.Index' (duration: 167.579µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:11:59.584174Z","caller":"traceutil/trace.go:171","msg":"trace[36421446] transaction","detail":"{read_only:false; response_revision:2644; number_of_response:1; }","duration":"860.164371ms","start":"2026-05-08T21:11:58.723945Z","end":"2026-05-08T21:11:59.58411Z","steps":["trace[36421446] 'process raft request' (duration: 859.907658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:11:59.584421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.472468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-08T21:11:59.584521Z","caller":"traceutil/trace.go:171","msg":"trace[443552997] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2644; }","duration":"276.618785ms","start":"2026-05-08T21:11:59.307874Z","end":"2026-05-08T21:11:59.584493Z","steps":["trace[443552997] 'agreement among raft nodes before linearized reading' (duration: 276.301758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:11:59.58448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.550885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:11:59.5846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.057433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-08T21:11:59.584656Z","caller":"traceutil/trace.go:171","msg":"trace[541952770] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2644; }","duration":"179.168839ms","start":"2026-05-08T21:11:59.405472Z","end":"2026-05-08T21:11:59.584641Z","steps":["trace[541952770] 'agreement among raft nodes before linearized reading' (duration: 178.964419ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:11:59.584687Z","caller":"traceutil/trace.go:171","msg":"trace[1053559475] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2644; }","duration":"222.781797ms","start":"2026-05-08T21:11:59.361844Z","end":"2026-05-08T21:11:59.584625Z","steps":["trace[1053559475] 'agreement among raft nodes before linearized reading' (duration: 222.47208ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:11:59.584852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:58.723905Z","time spent":"860.406243ms","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:12:01.095865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.40081995s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:12:01.096124Z","caller":"traceutil/trace.go:171","msg":"trace[643677898] transaction","detail":"{read_only:false; response_revision:2648; number_of_response:1; }","duration":"1.238720994s","start":"2026-05-08T21:11:59.857377Z","end":"2026-05-08T21:12:01.096098Z","steps":["trace[643677898] 'process raft request' (duration: 1.23864699s)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:12:01.096106Z","caller":"traceutil/trace.go:171","msg":"trace[1763580005] transaction","detail":"{read_only:false; response_revision:2647; number_of_response:1; }","duration":"1.464479145s","start":"2026-05-08T21:11:59.631585Z","end":"2026-05-08T21:12:01.096064Z","steps":["trace[1763580005] 'process raft request' (duration: 63.321269ms)","trace[1763580005] 'compare' (duration: 1.400632359s)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:12:01.09631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:59.631571Z","time spent":"1.464624343s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:12:01.096681Z","caller":"traceutil/trace.go:171","msg":"trace[609590619] linearizableReadLoop","detail":"{readStateIndex:2744; appliedIndex:2743; }","duration":"1.454739901s","start":"2026-05-08T21:11:59.641926Z","end":"2026-05-08T21:12:01.096666Z","steps":["trace[609590619] 'read index received' (duration: 52.918869ms)","trace[609590619] 'applied index is now lower than readState.Index' (duration: 1.401819702s)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:12:01.096894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.454973273s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7460"} {"level":"info","ts":"2026-05-08T21:12:01.096924Z","caller":"traceutil/trace.go:171","msg":"trace[192436806] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2648; }","duration":"1.455007435s","start":"2026-05-08T21:11:59.641909Z","end":"2026-05-08T21:12:01.096916Z","steps":["trace[192436806] 'agreement among raft nodes before linearized reading' (duration: 1.454836966s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:01.096954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:59.641874Z","time spent":"1.455073979s","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":7483,"request content":"key:\"/registry/statefulsets/auth-system/keycloak\" "} {"level":"warn","ts":"2026-05-08T21:12:01.097098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:59.857345Z","time spent":"1.23883303s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:12:01.173178Z","caller":"traceutil/trace.go:171","msg":"trace[2145535769] transaction","detail":"{read_only:false; response_revision:2649; number_of_response:1; }","duration":"733.21964ms","start":"2026-05-08T21:12:00.439919Z","end":"2026-05-08T21:12:01.173138Z","steps":["trace[2145535769] 'process raft request' (duration: 732.901164ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:12:01.17351Z","caller":"traceutil/trace.go:171","msg":"trace[696902746] transaction","detail":"{read_only:false; response_revision:2650; number_of_response:1; }","duration":"719.108147ms","start":"2026-05-08T21:12:00.454368Z","end":"2026-05-08T21:12:01.173476Z","steps":["trace[696902746] 'process raft request' (duration: 718.691026ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:12:01.173621Z","caller":"traceutil/trace.go:171","msg":"trace[140187273] transaction","detail":"{read_only:false; response_revision:2651; number_of_response:1; }","duration":"715.511093ms","start":"2026-05-08T21:12:00.45809Z","end":"2026-05-08T21:12:01.173601Z","steps":["trace[140187273] 'process raft request' (duration: 715.421747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:01.173657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:12:00.454355Z","time spent":"719.229434ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:12:01.173751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:12:00.458081Z","time spent":"715.596667ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:12:01.173604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:12:00.439896Z","time spent":"733.39832ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:12:01.37204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.282273ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-08T21:12:01.372243Z","caller":"traceutil/trace.go:171","msg":"trace[2053265803] linearizableReadLoop","detail":"{readStateIndex:2749; appliedIndex:2745; }","duration":"275.506004ms","start":"2026-05-08T21:12:01.096715Z","end":"2026-05-08T21:12:01.372221Z","steps":["trace[2053265803] 'read index received' (duration: 76.071742ms)","trace[2053265803] 'applied index is now lower than readState.Index' (duration: 199.432552ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:12:01.372464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100469008s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:12:01.372553Z","caller":"traceutil/trace.go:171","msg":"trace[1692078094] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:2651; }","duration":"1.100623227s","start":"2026-05-08T21:12:00.271914Z","end":"2026-05-08T21:12:01.372537Z","steps":["trace[1692078094] 'agreement among raft nodes before linearized reading' (duration: 1.100496829s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:01.372594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:12:00.271881Z","time spent":"1.100702402s","remote":"127.0.0.1:36412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:12:01.372573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.512065678s","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-05-08T21:12:01.372522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.694504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:12:01.372656Z","caller":"traceutil/trace.go:171","msg":"trace[653122271] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2651; }","duration":"1.512197815s","start":"2026-05-08T21:11:59.860443Z","end":"2026-05-08T21:12:01.37264Z","steps":["trace[653122271] 'agreement among raft nodes before linearized reading' (duration: 1.51192705s)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:12:01.372692Z","caller":"traceutil/trace.go:171","msg":"trace[145518547] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:2651; }","duration":"126.945076ms","start":"2026-05-08T21:12:01.245724Z","end":"2026-05-08T21:12:01.372669Z","steps":["trace[145518547] 'agreement among raft nodes before linearized reading' (duration: 126.683592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:01.372669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008509059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:12:01.37261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.069839701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:12:01.37278Z","caller":"traceutil/trace.go:171","msg":"trace[1826811250] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2651; }","duration":"1.008679928s","start":"2026-05-08T21:12:00.364076Z","end":"2026-05-08T21:12:01.372756Z","steps":["trace[1826811250] 'agreement among raft nodes before linearized reading' (duration: 1.008443076s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:01.372803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.513695982s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-08T21:12:01.372827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:12:00.364055Z","time spent":"1.008763652s","remote":"127.0.0.1:43166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T21:12:01.372832Z","caller":"traceutil/trace.go:171","msg":"trace[585267520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2651; }","duration":"1.513757305s","start":"2026-05-08T21:11:59.859067Z","end":"2026-05-08T21:12:01.372824Z","steps":["trace[585267520] 'agreement among raft nodes before linearized reading' (duration: 1.513353554s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:01.37287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:59.859036Z","time spent":"1.513828449s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-08T21:12:01.372872Z","caller":"traceutil/trace.go:171","msg":"trace[1452407622] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:2651; }","duration":"1.070164017s","start":"2026-05-08T21:12:00.30263Z","end":"2026-05-08T21:12:01.372794Z","steps":["trace[1452407622] 'agreement among raft nodes before linearized reading' (duration: 1.069649869s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:01.372714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:59.860421Z","time spent":"1.512284569s","remote":"127.0.0.1:43486","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-05-08T21:12:01.372998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:12:00.302598Z","time spent":"1.070355717s","remote":"127.0.0.1:43566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":90,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:12:01.373095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.491126094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-08T21:12:01.373107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.455939811s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-08T21:12:01.373139Z","caller":"traceutil/trace.go:171","msg":"trace[192048708] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2651; }","duration":"1.456047047s","start":"2026-05-08T21:11:59.917084Z","end":"2026-05-08T21:12:01.373131Z","steps":["trace[192048708] 'agreement among raft nodes before linearized reading' (duration: 1.455214403s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:01.373462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:59.917052Z","time spent":"1.456399425s","remote":"127.0.0.1:43486","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":"info","ts":"2026-05-08T21:12:01.373137Z","caller":"traceutil/trace.go:171","msg":"trace[626085707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2651; }","duration":"1.491178377s","start":"2026-05-08T21:11:59.881949Z","end":"2026-05-08T21:12:01.373127Z","steps":["trace[626085707] 'agreement among raft nodes before linearized reading' (duration: 1.490384835s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:01.37253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.176716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:12:01.373643Z","caller":"traceutil/trace.go:171","msg":"trace[1198662290] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:2651; }","duration":"548.333616ms","start":"2026-05-08T21:12:00.825297Z","end":"2026-05-08T21:12:01.37363Z","steps":["trace[1198662290] 'agreement among raft nodes before linearized reading' (duration: 547.108322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:01.373677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:12:00.825274Z","time spent":"548.393639ms","remote":"127.0.0.1:43700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":3,"response size":30,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:12:01.373599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:11:59.881944Z","time spent":"1.491621629s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-08T21:12:21.657342Z","caller":"traceutil/trace.go:171","msg":"trace[1361688779] linearizableReadLoop","detail":"{readStateIndex:2858; appliedIndex:2857; }","duration":"174.140595ms","start":"2026-05-08T21:12:21.483182Z","end":"2026-05-08T21:12:21.657323Z","steps":["trace[1361688779] 'read index received' (duration: 173.955985ms)","trace[1361688779] 'applied index is now lower than readState.Index' (duration: 183.73µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:12:21.657399Z","caller":"traceutil/trace.go:171","msg":"trace[1208897216] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"187.780863ms","start":"2026-05-08T21:12:21.46959Z","end":"2026-05-08T21:12:21.657371Z","steps":["trace[1208897216] 'process raft request' (duration: 187.616524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:21.657556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.363617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-08T21:12:21.657599Z","caller":"traceutil/trace.go:171","msg":"trace[1788411365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2756; }","duration":"174.436131ms","start":"2026-05-08T21:12:21.483152Z","end":"2026-05-08T21:12:21.657588Z","steps":["trace[1788411365] 'agreement among raft nodes before linearized reading' (duration: 174.299383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:21.657651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.219808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-08T21:12:21.65773Z","caller":"traceutil/trace.go:171","msg":"trace[5872140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2756; }","duration":"174.327723ms","start":"2026-05-08T21:12:21.483387Z","end":"2026-05-08T21:12:21.657715Z","steps":["trace[5872140] 'agreement among raft nodes before linearized reading' (duration: 174.134463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:21.657909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.908148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-08T21:12:21.657928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.50205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-08T21:12:21.657952Z","caller":"traceutil/trace.go:171","msg":"trace[1624926484] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2756; }","duration":"169.969501ms","start":"2026-05-08T21:12:21.487975Z","end":"2026-05-08T21:12:21.657945Z","steps":["trace[1624926484] 'agreement among raft nodes before linearized reading' (duration: 169.885797ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:12:21.657961Z","caller":"traceutil/trace.go:171","msg":"trace[1545310816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2756; }","duration":"173.547823ms","start":"2026-05-08T21:12:21.484402Z","end":"2026-05-08T21:12:21.65795Z","steps":["trace[1545310816] 'agreement among raft nodes before linearized reading' (duration: 173.462768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:08.096133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.465483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:08.09622Z","caller":"traceutil/trace.go:171","msg":"trace[1959177525] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:3000; }","duration":"138.603841ms","start":"2026-05-08T21:13:07.957594Z","end":"2026-05-08T21:13:08.096198Z","steps":["trace[1959177525] 'count revisions from in-memory index tree' (duration: 138.386589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:08.096223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.462314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-08T21:13:08.096238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.120461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-08T21:13:08.096575Z","caller":"traceutil/trace.go:171","msg":"trace[516138202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3000; }","duration":"143.245218ms","start":"2026-05-08T21:13:07.953057Z","end":"2026-05-08T21:13:08.096302Z","steps":["trace[516138202] 'range keys from in-memory index tree' (duration: 142.92174ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:08.096594Z","caller":"traceutil/trace.go:171","msg":"trace[177464402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3000; }","duration":"140.592731ms","start":"2026-05-08T21:13:07.955697Z","end":"2026-05-08T21:13:08.09629Z","steps":["trace[177464402] 'range keys from in-memory index tree' (duration: 140.138516ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:08.096603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.428426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-08T21:13:08.096712Z","caller":"traceutil/trace.go:171","msg":"trace[1058603683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3000; }","duration":"139.602166ms","start":"2026-05-08T21:13:07.957087Z","end":"2026-05-08T21:13:08.096689Z","steps":["trace[1058603683] 'range keys from in-memory index tree' (duration: 138.843474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:08.096824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.566222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-08T21:13:08.096856Z","caller":"traceutil/trace.go:171","msg":"trace[565045495] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3000; }","duration":"144.622746ms","start":"2026-05-08T21:13:07.952228Z","end":"2026-05-08T21:13:08.09685Z","steps":["trace[565045495] 'range keys from in-memory index tree' (duration: 143.728846ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:38.386785Z","caller":"traceutil/trace.go:171","msg":"trace[1023013403] linearizableReadLoop","detail":"{readStateIndex:3273; appliedIndex:3272; }","duration":"110.592865ms","start":"2026-05-08T21:13:38.276175Z","end":"2026-05-08T21:13:38.386768Z","steps":["trace[1023013403] 'read index received' (duration: 110.3892ms)","trace[1023013403] 'applied index is now lower than readState.Index' (duration: 202.925µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:13:38.386877Z","caller":"traceutil/trace.go:171","msg":"trace[1416962636] transaction","detail":"{read_only:false; response_revision:3155; number_of_response:1; }","duration":"290.823914ms","start":"2026-05-08T21:13:38.096045Z","end":"2026-05-08T21:13:38.386869Z","steps":["trace[1416962636] 'process raft request' (duration: 290.587539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:38.38725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.052435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-08T21:13:38.387338Z","caller":"traceutil/trace.go:171","msg":"trace[976292719] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3155; }","duration":"111.194094ms","start":"2026-05-08T21:13:38.276114Z","end":"2026-05-08T21:13:38.387308Z","steps":["trace[976292719] 'agreement among raft nodes before linearized reading' (duration: 110.938739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:38.768277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.723468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:13:38.768372Z","caller":"traceutil/trace.go:171","msg":"trace[875016873] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:3159; }","duration":"212.890055ms","start":"2026-05-08T21:13:38.55546Z","end":"2026-05-08T21:13:38.76835Z","steps":["trace[875016873] 'count revisions from in-memory index tree' (duration: 212.655409ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:48.631799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.11001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:13:48.632058Z","caller":"traceutil/trace.go:171","msg":"trace[925441827] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:3206; }","duration":"110.415274ms","start":"2026-05-08T21:13:48.52163Z","end":"2026-05-08T21:13:48.632045Z","steps":["trace[925441827] 'count revisions from in-memory index tree' (duration: 110.037071ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:55.605095Z","caller":"traceutil/trace.go:171","msg":"trace[371185083] transaction","detail":"{read_only:false; response_revision:3307; number_of_response:1; }","duration":"238.156878ms","start":"2026-05-08T21:13:55.3669Z","end":"2026-05-08T21:13:55.605057Z","steps":["trace[371185083] 'process raft request' (duration: 237.96348ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:55.605087Z","caller":"traceutil/trace.go:171","msg":"trace[539178203] transaction","detail":"{read_only:false; response_revision:3306; number_of_response:1; }","duration":"239.109367ms","start":"2026-05-08T21:13:55.365929Z","end":"2026-05-08T21:13:55.605039Z","steps":["trace[539178203] 'process raft request' (duration: 207.888034ms)","trace[539178203] 'compare' (duration: 30.866927ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:13:56.948576Z","caller":"traceutil/trace.go:171","msg":"trace[282397290] transaction","detail":"{read_only:false; response_revision:3331; number_of_response:1; }","duration":"210.605649ms","start":"2026-05-08T21:13:56.737951Z","end":"2026-05-08T21:13:56.948556Z","steps":["trace[282397290] 'process raft request' (duration: 140.36803ms)","trace[282397290] 'compare' (duration: 70.090201ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:13:56.948792Z","caller":"traceutil/trace.go:171","msg":"trace[1744740844] transaction","detail":"{read_only:false; response_revision:3332; number_of_response:1; }","duration":"209.61067ms","start":"2026-05-08T21:13:56.739153Z","end":"2026-05-08T21:13:56.948764Z","steps":["trace[1744740844] 'process raft request' (duration: 209.374102ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:56.949007Z","caller":"traceutil/trace.go:171","msg":"trace[1300394308] transaction","detail":"{read_only:false; response_revision:3333; number_of_response:1; }","duration":"207.619241ms","start":"2026-05-08T21:13:56.74137Z","end":"2026-05-08T21:13:56.948989Z","steps":["trace[1300394308] 'process raft request' (duration: 207.296125ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:58.181096Z","caller":"traceutil/trace.go:171","msg":"trace[895215895] transaction","detail":"{read_only:false; response_revision:3339; number_of_response:1; }","duration":"129.751233ms","start":"2026-05-08T21:13:58.051313Z","end":"2026-05-08T21:13:58.181064Z","steps":["trace[895215895] 'process raft request' (duration: 129.570665ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:58.901194Z","caller":"traceutil/trace.go:171","msg":"trace[1599764876] linearizableReadLoop","detail":"{readStateIndex:3465; appliedIndex:3464; }","duration":"118.430167ms","start":"2026-05-08T21:13:58.782735Z","end":"2026-05-08T21:13:58.901165Z","steps":["trace[1599764876] 'read index received' (duration: 118.195689ms)","trace[1599764876] 'applied index is now lower than readState.Index' (duration: 233.638µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:13:58.901264Z","caller":"traceutil/trace.go:171","msg":"trace[1234557468] transaction","detail":"{read_only:false; response_revision:3340; number_of_response:1; }","duration":"318.072546ms","start":"2026-05-08T21:13:58.583158Z","end":"2026-05-08T21:13:58.90123Z","steps":["trace[1234557468] 'process raft request' (duration: 317.840729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:58.901454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.706494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-08T21:13:58.901533Z","caller":"traceutil/trace.go:171","msg":"trace[835306729] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3340; }","duration":"118.868803ms","start":"2026-05-08T21:13:58.78265Z","end":"2026-05-08T21:13:58.901518Z","steps":["trace[835306729] 'agreement among raft nodes before linearized reading' (duration: 118.645644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:58.901693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:58.583138Z","time spent":"318.198165ms","remote":"127.0.0.1:43486","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-05-08T21:14:01.012984Z","caller":"traceutil/trace.go:171","msg":"trace[428778651] transaction","detail":"{read_only:false; response_revision:3356; number_of_response:1; }","duration":"102.205294ms","start":"2026-05-08T21:14:00.910747Z","end":"2026-05-08T21:14:01.012952Z","steps":["trace[428778651] 'process raft request' (duration: 101.983807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:01.210761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.593788ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-08T21:14:01.210896Z","caller":"traceutil/trace.go:171","msg":"trace[428747636] linearizableReadLoop","detail":"{readStateIndex:3483; appliedIndex:3481; }","duration":"244.187736ms","start":"2026-05-08T21:14:00.966675Z","end":"2026-05-08T21:14:01.210862Z","steps":["trace[428747636] 'read index received' (duration: 46.04067ms)","trace[428747636] 'applied index is now lower than readState.Index' (duration: 198.145266ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:01.211113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.428244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-08T21:14:01.211178Z","caller":"traceutil/trace.go:171","msg":"trace[1624838099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3356; }","duration":"244.535023ms","start":"2026-05-08T21:14:00.96663Z","end":"2026-05-08T21:14:01.211165Z","steps":["trace[1624838099] 'agreement among raft nodes before linearized reading' (duration: 244.332925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:01.211491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.829839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-08T21:14:01.211583Z","caller":"traceutil/trace.go:171","msg":"trace[1762246823] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3356; }","duration":"140.904258ms","start":"2026-05-08T21:14:01.070627Z","end":"2026-05-08T21:14:01.211531Z","steps":["trace[1762246823] 'agreement among raft nodes before linearized reading' (duration: 140.759078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:01.211594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.505262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-08T21:14:01.211633Z","caller":"traceutil/trace.go:171","msg":"trace[2064627592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3356; }","duration":"141.558592ms","start":"2026-05-08T21:14:01.070064Z","end":"2026-05-08T21:14:01.211622Z","steps":["trace[2064627592] 'agreement among raft nodes before linearized reading' (duration: 141.476342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:01.211855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.64628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-08T21:14:01.211902Z","caller":"traceutil/trace.go:171","msg":"trace[1571177371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3356; }","duration":"142.332895ms","start":"2026-05-08T21:14:01.069557Z","end":"2026-05-08T21:14:01.21189Z","steps":["trace[1571177371] 'agreement among raft nodes before linearized reading' (duration: 141.560711ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:13.238462Z","caller":"traceutil/trace.go:171","msg":"trace[1390692336] transaction","detail":"{read_only:false; response_revision:3422; number_of_response:1; }","duration":"108.068336ms","start":"2026-05-08T21:14:13.130371Z","end":"2026-05-08T21:14:13.238439Z","steps":["trace[1390692336] 'process raft request' (duration: 107.733717ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:59.057097Z","caller":"traceutil/trace.go:171","msg":"trace[216585496] transaction","detail":"{read_only:false; response_revision:3679; number_of_response:1; }","duration":"104.324066ms","start":"2026-05-08T21:14:58.952749Z","end":"2026-05-08T21:14:59.057073Z","steps":["trace[216585496] 'process raft request' (duration: 51.724576ms)","trace[216585496] 'compare' (duration: 52.482788ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:14:59.078786Z","caller":"traceutil/trace.go:171","msg":"trace[673339414] transaction","detail":"{read_only:false; response_revision:3680; number_of_response:1; }","duration":"119.799597ms","start":"2026-05-08T21:14:58.958964Z","end":"2026-05-08T21:14:59.078763Z","steps":["trace[673339414] 'process raft request' (duration: 119.724876ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:59.078846Z","caller":"traceutil/trace.go:171","msg":"trace[2086996251] transaction","detail":"{read_only:false; number_of_response:1; response_revision:3679; }","duration":"122.628548ms","start":"2026-05-08T21:14:58.956189Z","end":"2026-05-08T21:14:59.078817Z","steps":["trace[2086996251] 'process raft request' (duration: 122.409455ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:43.592445Z","caller":"traceutil/trace.go:171","msg":"trace[489719830] transaction","detail":"{read_only:false; response_revision:4006; number_of_response:1; }","duration":"113.538849ms","start":"2026-05-08T21:15:43.478859Z","end":"2026-05-08T21:15:43.592398Z","steps":["trace[489719830] 'process raft request' (duration: 113.306983ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:44.030614Z","caller":"traceutil/trace.go:171","msg":"trace[41164620] transaction","detail":"{read_only:false; response_revision:4011; number_of_response:1; }","duration":"112.252555ms","start":"2026-05-08T21:15:43.918332Z","end":"2026-05-08T21:15:44.030584Z","steps":["trace[41164620] 'process raft request' (duration: 112.204434ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:44.030793Z","caller":"traceutil/trace.go:171","msg":"trace[1232964885] transaction","detail":"{read_only:false; response_revision:4010; number_of_response:1; }","duration":"112.702265ms","start":"2026-05-08T21:15:43.918055Z","end":"2026-05-08T21:15:44.030757Z","steps":["trace[1232964885] 'process raft request' (duration: 112.393138ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:44.030841Z","caller":"traceutil/trace.go:171","msg":"trace[975522642] transaction","detail":"{read_only:false; response_revision:4009; number_of_response:1; }","duration":"113.263928ms","start":"2026-05-08T21:15:43.917512Z","end":"2026-05-08T21:15:44.030776Z","steps":["trace[975522642] 'process raft request' (duration: 54.320211ms)","trace[975522642] 'compare' (duration: 58.371894ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:44.33726Z","caller":"traceutil/trace.go:171","msg":"trace[536836763] transaction","detail":"{read_only:false; response_revision:4012; number_of_response:1; }","duration":"123.612814ms","start":"2026-05-08T21:15:44.21362Z","end":"2026-05-08T21:15:44.337233Z","steps":["trace[536836763] 'process raft request' (duration: 123.446829ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:44.395357Z","caller":"traceutil/trace.go:171","msg":"trace[1200812921] transaction","detail":"{read_only:false; response_revision:4014; number_of_response:1; }","duration":"172.049964ms","start":"2026-05-08T21:15:44.223281Z","end":"2026-05-08T21:15:44.395331Z","steps":["trace[1200812921] 'process raft request' (duration: 171.953762ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:44.395598Z","caller":"traceutil/trace.go:171","msg":"trace[1526825256] transaction","detail":"{read_only:false; response_revision:4013; number_of_response:1; }","duration":"175.771445ms","start":"2026-05-08T21:15:44.219795Z","end":"2026-05-08T21:15:44.395567Z","steps":["trace[1526825256] 'process raft request' (duration: 175.208343ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:44.39568Z","caller":"traceutil/trace.go:171","msg":"trace[312332456] transaction","detail":"{read_only:false; response_revision:4015; number_of_response:1; }","duration":"172.149235ms","start":"2026-05-08T21:15:44.22349Z","end":"2026-05-08T21:15:44.395639Z","steps":["trace[312332456] 'process raft request' (duration: 171.801618ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:44.780953Z","caller":"traceutil/trace.go:171","msg":"trace[451701714] transaction","detail":"{read_only:false; response_revision:4017; number_of_response:1; }","duration":"141.002747ms","start":"2026-05-08T21:15:44.639879Z","end":"2026-05-08T21:15:44.780881Z","steps":["trace[451701714] 'process raft request' (duration: 129.530243ms)","trace[451701714] 'compare' (duration: 11.213298ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:44.90295Z","caller":"traceutil/trace.go:171","msg":"trace[1199362369] transaction","detail":"{read_only:false; response_revision:4018; number_of_response:1; }","duration":"113.607932ms","start":"2026-05-08T21:15:44.789309Z","end":"2026-05-08T21:15:44.902917Z","steps":["trace[1199362369] 'process raft request' (duration: 110.878982ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:48.475557Z","caller":"traceutil/trace.go:171","msg":"trace[1667479248] linearizableReadLoop","detail":"{readStateIndex:4551; appliedIndex:4550; }","duration":"124.464967ms","start":"2026-05-08T21:15:48.351062Z","end":"2026-05-08T21:15:48.475527Z","steps":["trace[1667479248] 'read index received' (duration: 106.192099ms)","trace[1667479248] 'applied index is now lower than readState.Index' (duration: 18.270958ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:48.475764Z","caller":"traceutil/trace.go:171","msg":"trace[604354869] transaction","detail":"{read_only:false; response_revision:4382; number_of_response:1; }","duration":"124.974228ms","start":"2026-05-08T21:15:48.350742Z","end":"2026-05-08T21:15:48.475716Z","steps":["trace[604354869] 'process raft request' (duration: 106.567348ms)","trace[604354869] 'compare' (duration: 17.924749ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:48.476031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.951438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-08T21:15:48.476078Z","caller":"traceutil/trace.go:171","msg":"trace[254371661] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4382; }","duration":"125.053641ms","start":"2026-05-08T21:15:48.351014Z","end":"2026-05-08T21:15:48.476068Z","steps":["trace[254371661] 'agreement among raft nodes before linearized reading' (duration: 124.824735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:48.476792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.611695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:48.476845Z","caller":"traceutil/trace.go:171","msg":"trace[2020303668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4387; }","duration":"115.686156ms","start":"2026-05-08T21:15:48.361147Z","end":"2026-05-08T21:15:48.476834Z","steps":["trace[2020303668] 'agreement among raft nodes before linearized reading' (duration: 115.600184ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:48.476987Z","caller":"traceutil/trace.go:171","msg":"trace[469830428] transaction","detail":"{read_only:false; response_revision:4383; number_of_response:1; }","duration":"123.661468ms","start":"2026-05-08T21:15:48.353314Z","end":"2026-05-08T21:15:48.476976Z","steps":["trace[469830428] 'process raft request' (duration: 123.202968ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:51.751283Z","caller":"traceutil/trace.go:171","msg":"trace[546868754] transaction","detail":"{read_only:false; response_revision:4472; number_of_response:1; }","duration":"101.374996ms","start":"2026-05-08T21:15:51.649873Z","end":"2026-05-08T21:15:51.751248Z","steps":["trace[546868754] 'process raft request' (duration: 89.040867ms)","trace[546868754] 'compare' (duration: 12.206157ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:52.046207Z","caller":"traceutil/trace.go:171","msg":"trace[269496157] linearizableReadLoop","detail":"{readStateIndex:4645; appliedIndex:4644; }","duration":"111.604532ms","start":"2026-05-08T21:15:51.934578Z","end":"2026-05-08T21:15:52.046182Z","steps":["trace[269496157] 'read index received' (duration: 95.742048ms)","trace[269496157] 'applied index is now lower than readState.Index' (duration: 15.861174ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:52.046359Z","caller":"traceutil/trace.go:171","msg":"trace[1916975844] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4475; }","duration":"215.19332ms","start":"2026-05-08T21:15:51.831138Z","end":"2026-05-08T21:15:52.046331Z","steps":["trace[1916975844] 'process raft request' (duration: 199.149632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:52.046472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.88214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-08T21:15:52.04673Z","caller":"traceutil/trace.go:171","msg":"trace[2099381120] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4475; }","duration":"112.149006ms","start":"2026-05-08T21:15:51.934568Z","end":"2026-05-08T21:15:52.046717Z","steps":["trace[2099381120] 'agreement among raft nodes before linearized reading' (duration: 111.754756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:52.046855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.268769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-08T21:15:52.046913Z","caller":"traceutil/trace.go:171","msg":"trace[1773009119] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4475; }","duration":"103.3703ms","start":"2026-05-08T21:15:51.94353Z","end":"2026-05-08T21:15:52.0469Z","steps":["trace[1773009119] 'agreement among raft nodes before linearized reading' (duration: 102.989182ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:56.078352Z","caller":"traceutil/trace.go:171","msg":"trace[1413265946] transaction","detail":"{read_only:false; response_revision:4571; number_of_response:1; }","duration":"115.010072ms","start":"2026-05-08T21:15:55.963319Z","end":"2026-05-08T21:15:56.078329Z","steps":["trace[1413265946] 'process raft request' (duration: 114.791957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:56.529074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.115794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:15:56.529615Z","caller":"traceutil/trace.go:171","msg":"trace[1644430255] transaction","detail":"{read_only:false; response_revision:4574; number_of_response:1; }","duration":"366.305484ms","start":"2026-05-08T21:15:56.163241Z","end":"2026-05-08T21:15:56.529546Z","steps":["trace[1644430255] 'process raft request' (duration: 95.458003ms)","trace[1644430255] 'compare' (duration: 269.828817ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:56.529843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:56.163217Z","time spent":"366.51288ms","remote":"127.0.0.1:43486","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-05-08T21:15:56.529811Z","caller":"traceutil/trace.go:171","msg":"trace[517284298] linearizableReadLoop","detail":"{readStateIndex:4752; appliedIndex:4749; }","duration":"352.334665ms","start":"2026-05-08T21:15:56.177372Z","end":"2026-05-08T21:15:56.529707Z","steps":["trace[517284298] 'read index received' (duration: 81.408111ms)","trace[517284298] 'applied index is now lower than readState.Index' (duration: 270.925504ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:56.529923Z","caller":"traceutil/trace.go:171","msg":"trace[1495876016] transaction","detail":"{read_only:false; response_revision:4575; number_of_response:1; }","duration":"365.891495ms","start":"2026-05-08T21:15:56.164Z","end":"2026-05-08T21:15:56.529892Z","steps":["trace[1495876016] 'process raft request' (duration: 365.243219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:56.530221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:56.163985Z","time spent":"366.190642ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:15:56.529933Z","caller":"traceutil/trace.go:171","msg":"trace[1171814542] transaction","detail":"{read_only:false; response_revision:4576; number_of_response:1; }","duration":"363.907357ms","start":"2026-05-08T21:15:56.166Z","end":"2026-05-08T21:15:56.529907Z","steps":["trace[1171814542] 'process raft request' (duration: 363.667521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:56.530737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:56.165976Z","time spent":"364.645313ms","remote":"127.0.0.1:43486","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-05-08T21:15:56.530929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.536703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195929"} {"level":"info","ts":"2026-05-08T21:15:56.531025Z","caller":"traceutil/trace.go:171","msg":"trace[48735494] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4576; }","duration":"353.650136ms","start":"2026-05-08T21:15:56.177338Z","end":"2026-05-08T21:15:56.530988Z","steps":["trace[48735494] 'agreement among raft nodes before linearized reading' (duration: 352.634342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:56.531075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:56.177324Z","time spent":"353.739769ms","remote":"127.0.0.1:43310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2195952,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-05-08T21:15:57.795451Z","caller":"traceutil/trace.go:171","msg":"trace[875998907] linearizableReadLoop","detail":"{readStateIndex:4761; appliedIndex:4760; }","duration":"184.022192ms","start":"2026-05-08T21:15:57.611408Z","end":"2026-05-08T21:15:57.79543Z","steps":["trace[875998907] 'read index received' (duration: 183.922428ms)","trace[875998907] 'applied index is now lower than readState.Index' (duration: 98.104µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:57.795541Z","caller":"traceutil/trace.go:171","msg":"trace[1417545402] transaction","detail":"{read_only:false; response_revision:4585; number_of_response:1; }","duration":"186.850801ms","start":"2026-05-08T21:15:57.608633Z","end":"2026-05-08T21:15:57.795484Z","steps":["trace[1417545402] 'process raft request' (duration: 186.656915ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:57.795571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.147574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:57.795856Z","caller":"traceutil/trace.go:171","msg":"trace[1342664219] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:4585; }","duration":"184.448812ms","start":"2026-05-08T21:15:57.611397Z","end":"2026-05-08T21:15:57.795845Z","steps":["trace[1342664219] 'agreement among raft nodes before linearized reading' (duration: 184.108704ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:57.798914Z","caller":"traceutil/trace.go:171","msg":"trace[1782077279] transaction","detail":"{read_only:false; response_revision:4586; number_of_response:1; }","duration":"186.348638ms","start":"2026-05-08T21:15:57.612535Z","end":"2026-05-08T21:15:57.798884Z","steps":["trace[1782077279] 'process raft request' (duration: 186.160714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:02.285823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439931077343052,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T21:16:02.786084Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439931077343052,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T21:16:02.928251Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.242193667s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T21:16:02.928548Z","caller":"traceutil/trace.go:171","msg":"trace[149850030] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"1.242584038s","start":"2026-05-08T21:16:01.685943Z","end":"2026-05-08T21:16:02.928527Z","steps":["trace[149850030] 'process raft request' (duration: 1.242479455s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:02.928665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:01.685915Z","time spent":"1.24269076s","remote":"127.0.0.1:43402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:16:03.124209Z","caller":"traceutil/trace.go:171","msg":"trace[286150480] transaction","detail":"{read_only:false; response_revision:4666; number_of_response:1; }","duration":"574.087988ms","start":"2026-05-08T21:16:02.550086Z","end":"2026-05-08T21:16:03.124174Z","steps":["trace[286150480] 'process raft request' (duration: 573.850062ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:03.12423Z","caller":"traceutil/trace.go:171","msg":"trace[1565837371] linearizableReadLoop","detail":"{readStateIndex:4847; appliedIndex:4843; }","duration":"1.338752144s","start":"2026-05-08T21:16:01.785442Z","end":"2026-05-08T21:16:03.124194Z","steps":["trace[1565837371] 'read index received' (duration: 1.143087649s)","trace[1565837371] 'applied index is now lower than readState.Index' (duration: 195.661395ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:16:03.1243Z","caller":"traceutil/trace.go:171","msg":"trace[383240938] transaction","detail":"{read_only:false; response_revision:4667; number_of_response:1; }","duration":"567.104101ms","start":"2026-05-08T21:16:02.557186Z","end":"2026-05-08T21:16:03.12429Z","steps":["trace[383240938] 'process raft request' (duration: 566.898726ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:03.124247Z","caller":"traceutil/trace.go:171","msg":"trace[129839664] transaction","detail":"{read_only:false; response_revision:4668; number_of_response:1; }","duration":"564.041562ms","start":"2026-05-08T21:16:02.560182Z","end":"2026-05-08T21:16:03.124224Z","steps":["trace[129839664] 'process raft request' (duration: 563.93826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:03.124411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.557173Z","time spent":"567.160433ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:16:03.124446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.550067Z","time spent":"574.220412ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:16:03.124517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286819905s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"} {"level":"info","ts":"2026-05-08T21:16:03.124557Z","caller":"traceutil/trace.go:171","msg":"trace[820570205] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4669; }","duration":"1.286912849s","start":"2026-05-08T21:16:01.837635Z","end":"2026-05-08T21:16:03.124548Z","steps":["trace[820570205] 'agreement among raft nodes before linearized reading' (duration: 1.286749354s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:03.124599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:01.837616Z","time spent":"1.28697633s","remote":"127.0.0.1:43402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12233,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-08T21:16:03.124704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.560174Z","time spent":"564.224478ms","remote":"127.0.0.1:43486","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-05-08T21:16:03.124827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.451871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-08T21:16:03.124814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.346252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-08T21:16:03.124866Z","caller":"traceutil/trace.go:171","msg":"trace[225754809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4669; }","duration":"569.516682ms","start":"2026-05-08T21:16:02.55534Z","end":"2026-05-08T21:16:03.124857Z","steps":["trace[225754809] 'agreement among raft nodes before linearized reading' (duration: 569.42095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:03.124873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.464933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-08T21:16:03.124892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.555328Z","time spent":"569.558674ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-08T21:16:03.124893Z","caller":"traceutil/trace.go:171","msg":"trace[838872070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4669; }","duration":"568.460786ms","start":"2026-05-08T21:16:02.556413Z","end":"2026-05-08T21:16:03.124874Z","steps":["trace[838872070] 'agreement among raft nodes before linearized reading' (duration: 568.257301ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:03.124917Z","caller":"traceutil/trace.go:171","msg":"trace[1998266807] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:4669; }","duration":"229.539575ms","start":"2026-05-08T21:16:02.895367Z","end":"2026-05-08T21:16:03.124906Z","steps":["trace[1998266807] 'agreement among raft nodes before linearized reading' (duration: 229.454753ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:03.124935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.556404Z","time spent":"568.522317ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-08T21:16:03.124355Z","caller":"traceutil/trace.go:171","msg":"trace[313211496] transaction","detail":"{read_only:false; response_revision:4669; number_of_response:1; }","duration":"563.230353ms","start":"2026-05-08T21:16:02.561111Z","end":"2026-05-08T21:16:03.124341Z","steps":["trace[313211496] 'process raft request' (duration: 563.043308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:03.12508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.925308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:16:03.125094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.518159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:16:03.125122Z","caller":"traceutil/trace.go:171","msg":"trace[855581829] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:4669; }","duration":"436.987039ms","start":"2026-05-08T21:16:02.688121Z","end":"2026-05-08T21:16:03.125108Z","steps":["trace[855581829] 'agreement among raft nodes before linearized reading' (duration: 436.931528ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:03.125158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.688107Z","time spent":"437.042681ms","remote":"127.0.0.1:35674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:16:03.125192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.561103Z","time spent":"563.944081ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:16:03.125102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.339584926s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0aa97691-0c3b-43ec-8fb1-dc982c539225\" ","response":"range_response_count:1 size:3766"} {"level":"warn","ts":"2026-05-08T21:16:03.125347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.60993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:16:03.125354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.83225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-08T21:16:03.125391Z","caller":"traceutil/trace.go:171","msg":"trace[713245216] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:4669; }","duration":"531.651731ms","start":"2026-05-08T21:16:02.593727Z","end":"2026-05-08T21:16:03.125379Z","steps":["trace[713245216] 'agreement among raft nodes before linearized reading' (duration: 531.5896ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:03.125395Z","caller":"traceutil/trace.go:171","msg":"trace[1872990651] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4669; }","duration":"571.889962ms","start":"2026-05-08T21:16:02.553494Z","end":"2026-05-08T21:16:03.125384Z","steps":["trace[1872990651] 'agreement among raft nodes before linearized reading' (duration: 571.80137ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:03.125408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.753435ms","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-05-08T21:16:03.125425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.593717Z","time spent":"531.701432ms","remote":"127.0.0.1:44108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:16:03.125428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.553481Z","time spent":"571.941103ms","remote":"127.0.0.1:43486","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-05-08T21:16:03.125126Z","caller":"traceutil/trace.go:171","msg":"trace[2122047890] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:4669; }","duration":"200.576271ms","start":"2026-05-08T21:16:02.924539Z","end":"2026-05-08T21:16:03.125115Z","steps":["trace[2122047890] 'agreement among raft nodes before linearized reading' (duration: 200.527039ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:03.125449Z","caller":"traceutil/trace.go:171","msg":"trace[1006553598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4669; }","duration":"933.836467ms","start":"2026-05-08T21:16:02.1916Z","end":"2026-05-08T21:16:03.125437Z","steps":["trace[1006553598] 'agreement among raft nodes before linearized reading' (duration: 933.694843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:03.125539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.19158Z","time spent":"933.94824ms","remote":"127.0.0.1:43486","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-05-08T21:16:03.125275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.541159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:16:03.125486Z","caller":"traceutil/trace.go:171","msg":"trace[2104677678] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0aa97691-0c3b-43ec-8fb1-dc982c539225; range_end:; response_count:1; response_revision:4669; }","duration":"1.339945865s","start":"2026-05-08T21:16:01.785382Z","end":"2026-05-08T21:16:03.125328Z","steps":["trace[2104677678] 'agreement among raft nodes before linearized reading' (duration: 1.339054213s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:03.125243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.146557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-08T21:16:03.125664Z","caller":"traceutil/trace.go:171","msg":"trace[1679220609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4669; }","duration":"760.938029ms","start":"2026-05-08T21:16:02.364685Z","end":"2026-05-08T21:16:03.125623Z","steps":["trace[1679220609] 'agreement among raft nodes before linearized reading' (duration: 760.5688ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:03.125824Z","caller":"traceutil/trace.go:171","msg":"trace[276323832] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4669; }","duration":"942.708513ms","start":"2026-05-08T21:16:02.183039Z","end":"2026-05-08T21:16:03.125748Z","steps":["trace[276323832] 'agreement among raft nodes before linearized reading' (duration: 941.991985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:03.125872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.364662Z","time spent":"761.182967ms","remote":"127.0.0.1:43166","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-05-08T21:16:03.125894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:02.183018Z","time spent":"942.863957ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T21:16:03.125973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:01.785358Z","time spent":"1.340597563s","remote":"127.0.0.1:43402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3789,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0aa97691-0c3b-43ec-8fb1-dc982c539225\" "} {"level":"warn","ts":"2026-05-08T21:16:05.782093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.426603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:16:05.782194Z","caller":"traceutil/trace.go:171","msg":"trace[377110322] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:4692; }","duration":"104.597307ms","start":"2026-05-08T21:16:05.677564Z","end":"2026-05-08T21:16:05.782161Z","steps":["trace[377110322] 'count revisions from in-memory index tree' (duration: 104.353371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:05.782451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.481812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-08T21:16:05.782563Z","caller":"traceutil/trace.go:171","msg":"trace[864813533] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:4692; }","duration":"245.641046ms","start":"2026-05-08T21:16:05.536903Z","end":"2026-05-08T21:16:05.782544Z","steps":["trace[864813533] 'range keys from in-memory index tree' (duration: 245.260816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:05.782572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.779425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-wfxp9\" ","response":"range_response_count:1 size:5148"} {"level":"info","ts":"2026-05-08T21:16:05.782609Z","caller":"traceutil/trace.go:171","msg":"trace[962074837] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-wfxp9; range_end:; response_count:1; response_revision:4692; }","duration":"171.852357ms","start":"2026-05-08T21:16:05.610743Z","end":"2026-05-08T21:16:05.782595Z","steps":["trace[962074837] 'range keys from in-memory index tree' (duration: 171.58849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:05.782625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.512605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-wm6pt.18adb3a6bcbf8313\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-05-08T21:16:05.782691Z","caller":"traceutil/trace.go:171","msg":"trace[442901403] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-wm6pt.18adb3a6bcbf8313; range_end:; response_count:1; response_revision:4692; }","duration":"191.615198ms","start":"2026-05-08T21:16:05.591059Z","end":"2026-05-08T21:16:05.782674Z","steps":["trace[442901403] 'range keys from in-memory index tree' (duration: 191.381032ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:07.889491Z","caller":"traceutil/trace.go:171","msg":"trace[311569990] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"187.963955ms","start":"2026-05-08T21:16:07.701497Z","end":"2026-05-08T21:16:07.889461Z","steps":["trace[311569990] 'process raft request' (duration: 187.78967ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:07.894123Z","caller":"traceutil/trace.go:171","msg":"trace[316141471] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"145.254987ms","start":"2026-05-08T21:16:07.748852Z","end":"2026-05-08T21:16:07.894107Z","steps":["trace[316141471] 'process raft request' (duration: 145.167295ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:12.970354Z","caller":"traceutil/trace.go:171","msg":"trace[1120379488] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"159.145187ms","start":"2026-05-08T21:16:12.811168Z","end":"2026-05-08T21:16:12.970313Z","steps":["trace[1120379488] 'process raft request' (duration: 158.931711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:19.785249Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439931077343499,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T21:16:20.128539Z","caller":"traceutil/trace.go:171","msg":"trace[1495554121] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"954.403965ms","start":"2026-05-08T21:16:19.174109Z","end":"2026-05-08T21:16:20.128513Z","steps":["trace[1495554121] 'process raft request' (duration: 954.22783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.128713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.174077Z","time spent":"954.544098ms","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":891,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:16:20.222347Z","caller":"traceutil/trace.go:171","msg":"trace[1984232217] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"957.926236ms","start":"2026-05-08T21:16:19.264395Z","end":"2026-05-08T21:16:20.222321Z","steps":["trace[1984232217] 'process raft request' (duration: 915.295064ms)","trace[1984232217] 'compare' (duration: 42.365475ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:16:20.222538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.264369Z","time spent":"958.0496ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:16:20.222741Z","caller":"traceutil/trace.go:171","msg":"trace[670664752] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"946.260959ms","start":"2026-05-08T21:16:19.276466Z","end":"2026-05-08T21:16:20.222727Z","steps":["trace[670664752] 'process raft request' (duration: 945.781485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.222831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.276439Z","time spent":"946.334011ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:16:20.223001Z","caller":"traceutil/trace.go:171","msg":"trace[923419089] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"944.150741ms","start":"2026-05-08T21:16:19.278824Z","end":"2026-05-08T21:16:20.222975Z","steps":["trace[923419089] 'process raft request' (duration: 943.862503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.223152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.27881Z","time spent":"944.264454ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:16:20.223945Z","caller":"traceutil/trace.go:171","msg":"trace[228886181] linearizableReadLoop","detail":"{readStateIndex:5045; appliedIndex:5040; }","duration":"939.446398ms","start":"2026-05-08T21:16:19.284459Z","end":"2026-05-08T21:16:20.223906Z","steps":["trace[228886181] 'read index received' (duration: 843.856281ms)","trace[228886181] 'applied index is now lower than readState.Index' (duration: 95.588207ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:16:20.224211Z","caller":"traceutil/trace.go:171","msg":"trace[320160722] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"945.051026ms","start":"2026-05-08T21:16:19.279143Z","end":"2026-05-08T21:16:20.224194Z","steps":["trace[320160722] 'process raft request' (duration: 943.73248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.224332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"934.642294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-08T21:16:20.224422Z","caller":"traceutil/trace.go:171","msg":"trace[182186851] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4861; }","duration":"934.778038ms","start":"2026-05-08T21:16:19.289622Z","end":"2026-05-08T21:16:20.2244Z","steps":["trace[182186851] 'agreement among raft nodes before linearized reading' (duration: 934.573991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.224477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.289608Z","time spent":"934.855679ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-08T21:16:20.224499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.279095Z","time spent":"945.159179ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:16:20.224722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.271572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-08T21:16:20.224795Z","caller":"traceutil/trace.go:171","msg":"trace[2026323092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4861; }","duration":"940.382765ms","start":"2026-05-08T21:16:19.284402Z","end":"2026-05-08T21:16:20.224785Z","steps":["trace[2026323092] 'agreement among raft nodes before linearized reading' (duration: 940.256022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.224829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.28439Z","time spent":"940.429006ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T21:16:20.225042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.622092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-08T21:16:20.225105Z","caller":"traceutil/trace.go:171","msg":"trace[1622498720] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4861; }","duration":"924.742716ms","start":"2026-05-08T21:16:19.300351Z","end":"2026-05-08T21:16:20.225094Z","steps":["trace[1622498720] 'agreement among raft nodes before linearized reading' (duration: 924.608532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.225118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.203524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-08T21:16:20.225198Z","caller":"traceutil/trace.go:171","msg":"trace[894303513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4861; }","duration":"922.294157ms","start":"2026-05-08T21:16:19.302884Z","end":"2026-05-08T21:16:20.225179Z","steps":["trace[894303513] 'agreement among raft nodes before linearized reading' (duration: 922.02894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.225247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.302841Z","time spent":"922.39718ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T21:16:20.225256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.582729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-08T21:16:20.225331Z","caller":"traceutil/trace.go:171","msg":"trace[511029436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4861; }","duration":"925.693673ms","start":"2026-05-08T21:16:19.29962Z","end":"2026-05-08T21:16:20.225314Z","steps":["trace[511029436] 'agreement among raft nodes before linearized reading' (duration: 925.462836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.225371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.299606Z","time spent":"925.756734ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-08T21:16:20.225142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.300317Z","time spent":"924.817958ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T21:16:20.225032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.812917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:16:20.225504Z","caller":"traceutil/trace.go:171","msg":"trace[1306198291] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:4861; }","duration":"553.346643ms","start":"2026-05-08T21:16:19.672148Z","end":"2026-05-08T21:16:20.225495Z","steps":["trace[1306198291] 'agreement among raft nodes before linearized reading' (duration: 552.809338ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.225265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.472162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:16:20.225604Z","caller":"traceutil/trace.go:171","msg":"trace[1337642899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4861; }","duration":"860.879633ms","start":"2026-05-08T21:16:19.364704Z","end":"2026-05-08T21:16:20.225584Z","steps":["trace[1337642899] 'agreement among raft nodes before linearized reading' (duration: 860.359009ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.225548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.67212Z","time spent":"553.411294ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:16:20.22572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.364685Z","time spent":"861.020887ms","remote":"127.0.0.1:43166","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-05-08T21:16:20.225907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.326984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:16:20.226004Z","caller":"traceutil/trace.go:171","msg":"trace[388111169] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4861; }","duration":"439.22568ms","start":"2026-05-08T21:16:19.786728Z","end":"2026-05-08T21:16:20.225953Z","steps":["trace[388111169] 'agreement among raft nodes before linearized reading' (duration: 438.361145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.226111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:19.786703Z","time spent":"439.394084ms","remote":"127.0.0.1:44124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:16:20.494612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.47604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:16:20.494883Z","caller":"traceutil/trace.go:171","msg":"trace[1958043533] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"263.983188ms","start":"2026-05-08T21:16:20.230873Z","end":"2026-05-08T21:16:20.494857Z","steps":["trace[1958043533] 'process raft request' (duration: 99.133206ms)","trace[1958043533] 'compare' (duration: 163.894674ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:16:20.495009Z","caller":"traceutil/trace.go:171","msg":"trace[338573210] linearizableReadLoop","detail":"{readStateIndex:5050; appliedIndex:5045; }","duration":"130.301466ms","start":"2026-05-08T21:16:20.364687Z","end":"2026-05-08T21:16:20.494989Z","steps":["trace[338573210] 'read index received' (duration: 92.209542ms)","trace[338573210] 'applied index is now lower than readState.Index' (duration: 38.090584ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:16:20.495029Z","caller":"traceutil/trace.go:171","msg":"trace[730768719] transaction","detail":"{read_only:false; response_revision:4864; number_of_response:1; }","duration":"263.826134ms","start":"2026-05-08T21:16:20.23118Z","end":"2026-05-08T21:16:20.495006Z","steps":["trace[730768719] 'process raft request' (duration: 263.67148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:20.495154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.46453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:16:20.495215Z","caller":"traceutil/trace.go:171","msg":"trace[1938606768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4866; }","duration":"130.569733ms","start":"2026-05-08T21:16:20.364627Z","end":"2026-05-08T21:16:20.495197Z","steps":["trace[1938606768] 'agreement among raft nodes before linearized reading' (duration: 130.435979ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:20.49545Z","caller":"traceutil/trace.go:171","msg":"trace[202852987] transaction","detail":"{read_only:false; response_revision:4866; number_of_response:1; }","duration":"264.11775ms","start":"2026-05-08T21:16:20.231312Z","end":"2026-05-08T21:16:20.49543Z","steps":["trace[202852987] 'process raft request' (duration: 263.640477ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:20.495478Z","caller":"traceutil/trace.go:171","msg":"trace[365745761] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"264.181473ms","start":"2026-05-08T21:16:20.231239Z","end":"2026-05-08T21:16:20.495421Z","steps":["trace[365745761] 'process raft request' (duration: 263.666739ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:20.495556Z","caller":"traceutil/trace.go:171","msg":"trace[689830088] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"264.455082ms","start":"2026-05-08T21:16:20.231085Z","end":"2026-05-08T21:16:20.49554Z","steps":["trace[689830088] 'process raft request' (duration: 263.643129ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:21.237045Z","caller":"traceutil/trace.go:171","msg":"trace[1752079118] linearizableReadLoop","detail":"{readStateIndex:5054; appliedIndex:5053; }","duration":"134.794103ms","start":"2026-05-08T21:16:21.102206Z","end":"2026-05-08T21:16:21.237Z","steps":["trace[1752079118] 'read index received' (duration: 57.309645ms)","trace[1752079118] 'applied index is now lower than readState.Index' (duration: 77.482798ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:16:21.237283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.04022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-wm6pt.18adb3a471f9543a\" ","response":"range_response_count:1 size:832"} {"level":"info","ts":"2026-05-08T21:16:21.237334Z","caller":"traceutil/trace.go:171","msg":"trace[1598857574] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-wm6pt.18adb3a471f9543a; range_end:; response_count:1; response_revision:4869; }","duration":"135.146463ms","start":"2026-05-08T21:16:21.102166Z","end":"2026-05-08T21:16:21.237313Z","steps":["trace[1598857574] 'agreement among raft nodes before linearized reading' (duration: 134.952717ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:22.080184Z","caller":"traceutil/trace.go:171","msg":"trace[82522467] linearizableReadLoop","detail":"{readStateIndex:5057; appliedIndex:5056; }","duration":"223.020986ms","start":"2026-05-08T21:16:21.857137Z","end":"2026-05-08T21:16:22.080158Z","steps":["trace[82522467] 'read index received' (duration: 222.616545ms)","trace[82522467] 'applied index is now lower than readState.Index' (duration: 403.321µs)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:16:22.080384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.220971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:16:22.080429Z","caller":"traceutil/trace.go:171","msg":"trace[526425150] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:4872; }","duration":"223.322744ms","start":"2026-05-08T21:16:21.857093Z","end":"2026-05-08T21:16:22.080416Z","steps":["trace[526425150] 'agreement among raft nodes before linearized reading' (duration: 223.18674ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:22.080513Z","caller":"traceutil/trace.go:171","msg":"trace[361135592] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"242.800647ms","start":"2026-05-08T21:16:21.837647Z","end":"2026-05-08T21:16:22.080447Z","steps":["trace[361135592] 'process raft request' (duration: 242.19316ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:24.024158Z","caller":"traceutil/trace.go:171","msg":"trace[1981230310] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"126.608889ms","start":"2026-05-08T21:16:23.897509Z","end":"2026-05-08T21:16:24.024118Z","steps":["trace[1981230310] 'process raft request' (duration: 58.133504ms)","trace[1981230310] 'compare' (duration: 67.416166ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:16:24.277658Z","caller":"traceutil/trace.go:171","msg":"trace[256260420] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"152.177441ms","start":"2026-05-08T21:16:24.12546Z","end":"2026-05-08T21:16:24.277638Z","steps":["trace[256260420] 'process raft request' (duration: 152.049287ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:24.313339Z","caller":"traceutil/trace.go:171","msg":"trace[711422488] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"184.415259ms","start":"2026-05-08T21:16:24.128888Z","end":"2026-05-08T21:16:24.313303Z","steps":["trace[711422488] 'process raft request' (duration: 184.184493ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:25.0603Z","caller":"traceutil/trace.go:171","msg":"trace[725937245] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"120.785595ms","start":"2026-05-08T21:16:24.938772Z","end":"2026-05-08T21:16:25.059558Z","steps":["trace[725937245] 'process raft request' (duration: 77.235665ms)","trace[725937245] 'compare' (duration: 43.435656ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:16:53.166954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.435983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-08T21:16:53.167135Z","caller":"traceutil/trace.go:171","msg":"trace[485820830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5179; }","duration":"410.61289ms","start":"2026-05-08T21:16:52.756459Z","end":"2026-05-08T21:16:53.167071Z","steps":["trace[485820830] 'range keys from in-memory index tree' (duration: 410.260498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:53.167295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:52.756425Z","time spent":"410.854888ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T21:16:53.167523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.658887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-08T21:16:53.167751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.2611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-08T21:16:53.167806Z","caller":"traceutil/trace.go:171","msg":"trace[1370827891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5179; }","duration":"411.405545ms","start":"2026-05-08T21:16:52.756387Z","end":"2026-05-08T21:16:53.167793Z","steps":["trace[1370827891] 'range keys from in-memory index tree' (duration: 411.012113ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:53.167838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:52.75636Z","time spent":"411.468107ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-08T21:16:53.167872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.024222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-08T21:16:53.167948Z","caller":"traceutil/trace.go:171","msg":"trace[1712604859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5179; }","duration":"411.132065ms","start":"2026-05-08T21:16:52.756797Z","end":"2026-05-08T21:16:53.167929Z","steps":["trace[1712604859] 'range keys from in-memory index tree' (duration: 410.867527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:53.168098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:52.756784Z","time spent":"411.3015ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-08T21:16:53.168113Z","caller":"traceutil/trace.go:171","msg":"trace[1455590896] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5179; }","duration":"438.76237ms","start":"2026-05-08T21:16:52.728811Z","end":"2026-05-08T21:16:53.167573Z","steps":["trace[1455590896] 'range keys from in-memory index tree' (duration: 438.477441ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:53.168162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:52.728792Z","time spent":"439.352528ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-08T21:16:53.168262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.848787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-08T21:16:53.168293Z","caller":"traceutil/trace.go:171","msg":"trace[1620405330] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5179; }","duration":"419.877538ms","start":"2026-05-08T21:16:52.748404Z","end":"2026-05-08T21:16:53.168282Z","steps":["trace[1620405330] 'range keys from in-memory index tree' (duration: 419.679551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:53.168352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:52.748317Z","time spent":"420.028894ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T21:16:56.883429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.900441ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:16:56.883551Z","caller":"traceutil/trace.go:171","msg":"trace[1583619124] transaction","detail":"{read_only:false; response_revision:5196; number_of_response:1; }","duration":"359.54406ms","start":"2026-05-08T21:16:56.523982Z","end":"2026-05-08T21:16:56.883527Z","steps":["trace[1583619124] 'process raft request' (duration: 127.456283ms)","trace[1583619124] 'compare' (duration: 231.790847ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:16:56.88361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:56.523956Z","time spent":"359.627013ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:16:56.896842Z","caller":"traceutil/trace.go:171","msg":"trace[922252464] linearizableReadLoop","detail":"{readStateIndex:5391; appliedIndex:5389; }","duration":"115.717676ms","start":"2026-05-08T21:16:56.781105Z","end":"2026-05-08T21:16:56.896823Z","steps":["trace[922252464] 'read index received' (duration: 115.471899ms)","trace[922252464] 'applied index is now lower than readState.Index' (duration: 244.757µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:16:56.896888Z","caller":"traceutil/trace.go:171","msg":"trace[2088810844] transaction","detail":"{read_only:false; response_revision:5197; number_of_response:1; }","duration":"372.444473ms","start":"2026-05-08T21:16:56.524414Z","end":"2026-05-08T21:16:56.896858Z","steps":["trace[2088810844] 'process raft request' (duration: 372.225366ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:56.896924Z","caller":"traceutil/trace.go:171","msg":"trace[1597644072] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"371.910634ms","start":"2026-05-08T21:16:56.524984Z","end":"2026-05-08T21:16:56.896895Z","steps":["trace[1597644072] 'process raft request' (duration: 371.80424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:56.897036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:56.524398Z","time spent":"372.554106ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:16:56.89705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:56.524962Z","time spent":"372.023009ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:16:56.897217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.10332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:16:56.897282Z","caller":"traceutil/trace.go:171","msg":"trace[696872997] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:5198; }","duration":"116.240355ms","start":"2026-05-08T21:16:56.781032Z","end":"2026-05-08T21:16:56.897272Z","steps":["trace[696872997] 'agreement among raft nodes before linearized reading' (duration: 115.902913ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:13.147126Z","caller":"traceutil/trace.go:171","msg":"trace[1068877811] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"209.053892ms","start":"2026-05-08T21:17:12.938051Z","end":"2026-05-08T21:17:13.147105Z","steps":["trace[1068877811] 'process raft request' (duration: 208.930908ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:13.171018Z","caller":"traceutil/trace.go:171","msg":"trace[322735331] transaction","detail":"{read_only:false; response_revision:5311; number_of_response:1; }","duration":"118.934903ms","start":"2026-05-08T21:17:13.05206Z","end":"2026-05-08T21:17:13.170995Z","steps":["trace[322735331] 'process raft request' (duration: 118.89137ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:13.171219Z","caller":"traceutil/trace.go:171","msg":"trace[153057981] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"227.025304ms","start":"2026-05-08T21:17:12.944179Z","end":"2026-05-08T21:17:13.171204Z","steps":["trace[153057981] 'process raft request' (duration: 226.732413ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:13.171229Z","caller":"traceutil/trace.go:171","msg":"trace[1240551112] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"227.46636ms","start":"2026-05-08T21:17:12.943731Z","end":"2026-05-08T21:17:13.171198Z","steps":["trace[1240551112] 'process raft request' (duration: 227.061955ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:13.540894Z","caller":"traceutil/trace.go:171","msg":"trace[678445098] linearizableReadLoop","detail":"{readStateIndex:5510; appliedIndex:5509; }","duration":"112.231812ms","start":"2026-05-08T21:17:13.428554Z","end":"2026-05-08T21:17:13.540786Z","steps":["trace[678445098] 'read index received' (duration: 111.572378ms)","trace[678445098] 'applied index is now lower than readState.Index' (duration: 658.434µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:17:13.541059Z","caller":"traceutil/trace.go:171","msg":"trace[54232388] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"219.213271ms","start":"2026-05-08T21:17:13.32182Z","end":"2026-05-08T21:17:13.541034Z","steps":["trace[54232388] 'process raft request' (duration: 218.287879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:17:13.541169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.591864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-08T21:17:13.541204Z","caller":"traceutil/trace.go:171","msg":"trace[1983788935] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5313; }","duration":"112.669827ms","start":"2026-05-08T21:17:13.428524Z","end":"2026-05-08T21:17:13.541194Z","steps":["trace[1983788935] 'agreement among raft nodes before linearized reading' (duration: 112.502981ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:17:13.541457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.500977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-08T21:17:13.541458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.625747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-08T21:17:13.541504Z","caller":"traceutil/trace.go:171","msg":"trace[529821265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5313; }","duration":"109.5936ms","start":"2026-05-08T21:17:13.431899Z","end":"2026-05-08T21:17:13.541492Z","steps":["trace[529821265] 'agreement among raft nodes before linearized reading' (duration: 109.250258ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:13.541531Z","caller":"traceutil/trace.go:171","msg":"trace[210135680] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5313; }","duration":"108.755591ms","start":"2026-05-08T21:17:13.432755Z","end":"2026-05-08T21:17:13.541511Z","steps":["trace[210135680] 'agreement among raft nodes before linearized reading' (duration: 108.529384ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:15.297528Z","caller":"traceutil/trace.go:171","msg":"trace[883586743] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"122.209859ms","start":"2026-05-08T21:17:15.17529Z","end":"2026-05-08T21:17:15.2975Z","steps":["trace[883586743] 'process raft request' (duration: 122.144047ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:15.297539Z","caller":"traceutil/trace.go:171","msg":"trace[1733390304] transaction","detail":"{read_only:false; response_revision:5324; number_of_response:1; }","duration":"122.982296ms","start":"2026-05-08T21:17:15.174523Z","end":"2026-05-08T21:17:15.297505Z","steps":["trace[1733390304] 'process raft request' (duration: 53.680347ms)","trace[1733390304] 'compare' (duration: 69.087102ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:17:15.510206Z","caller":"traceutil/trace.go:171","msg":"trace[2013978744] transaction","detail":"{read_only:false; response_revision:5327; number_of_response:1; }","duration":"126.533178ms","start":"2026-05-08T21:17:15.383642Z","end":"2026-05-08T21:17:15.510175Z","steps":["trace[2013978744] 'process raft request' (duration: 26.425779ms)","trace[2013978744] 'compare' (duration: 99.810749ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:17:15.714151Z","caller":"traceutil/trace.go:171","msg":"trace[1121937193] linearizableReadLoop","detail":"{readStateIndex:5527; appliedIndex:5526; }","duration":"108.524994ms","start":"2026-05-08T21:17:15.6056Z","end":"2026-05-08T21:17:15.714125Z","steps":["trace[1121937193] 'read index received' (duration: 52.490106ms)","trace[1121937193] 'applied index is now lower than readState.Index' (duration: 56.033708ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:17:15.714213Z","caller":"traceutil/trace.go:171","msg":"trace[121784668] transaction","detail":"{read_only:false; response_revision:5329; number_of_response:1; }","duration":"145.705216ms","start":"2026-05-08T21:17:15.56848Z","end":"2026-05-08T21:17:15.714185Z","steps":["trace[121784668] 'process raft request' (duration: 89.613126ms)","trace[121784668] 'compare' (duration: 55.889333ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:17:15.714552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.932348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-05-08T21:17:15.714773Z","caller":"traceutil/trace.go:171","msg":"trace[345251141] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:5329; }","duration":"109.092683ms","start":"2026-05-08T21:17:15.605557Z","end":"2026-05-08T21:17:15.71465Z","steps":["trace[345251141] 'agreement among raft nodes before linearized reading' (duration: 108.747241ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:15.91263Z","caller":"traceutil/trace.go:171","msg":"trace[156676299] linearizableReadLoop","detail":"{readStateIndex:5530; appliedIndex:5527; }","duration":"191.935493ms","start":"2026-05-08T21:17:15.720677Z","end":"2026-05-08T21:17:15.912613Z","steps":["trace[156676299] 'read index received' (duration: 42.011811ms)","trace[156676299] 'applied index is now lower than readState.Index' (duration: 149.922682ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:17:15.912682Z","caller":"traceutil/trace.go:171","msg":"trace[800837060] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"192.769763ms","start":"2026-05-08T21:17:15.719878Z","end":"2026-05-08T21:17:15.912647Z","steps":["trace[800837060] 'process raft request' (duration: 183.850122ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:15.912735Z","caller":"traceutil/trace.go:171","msg":"trace[629758103] transaction","detail":"{read_only:false; response_revision:5332; number_of_response:1; }","duration":"192.09623ms","start":"2026-05-08T21:17:15.720627Z","end":"2026-05-08T21:17:15.912723Z","steps":["trace[629758103] 'process raft request' (duration: 191.916224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:17:15.912946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.254764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-08T21:17:15.912986Z","caller":"traceutil/trace.go:171","msg":"trace[1593855945] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:5332; }","duration":"192.322167ms","start":"2026-05-08T21:17:15.720654Z","end":"2026-05-08T21:17:15.912977Z","steps":["trace[1593855945] 'agreement among raft nodes before linearized reading' (duration: 192.241514ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:17:15.913156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.193283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:17:15.913196Z","caller":"traceutil/trace.go:171","msg":"trace[532435552] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:5332; }","duration":"146.249094ms","start":"2026-05-08T21:17:15.766934Z","end":"2026-05-08T21:17:15.913183Z","steps":["trace[532435552] 'agreement among raft nodes before linearized reading' (duration: 146.188322ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:18.472531Z","caller":"traceutil/trace.go:171","msg":"trace[1021216300] linearizableReadLoop","detail":"{readStateIndex:5545; appliedIndex:5544; }","duration":"134.725903ms","start":"2026-05-08T21:17:18.337783Z","end":"2026-05-08T21:17:18.472509Z","steps":["trace[1021216300] 'read index received' (duration: 134.539636ms)","trace[1021216300] 'applied index is now lower than readState.Index' (duration: 185.277µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:17:18.472601Z","caller":"traceutil/trace.go:171","msg":"trace[2009285952] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"243.129963ms","start":"2026-05-08T21:17:18.22944Z","end":"2026-05-08T21:17:18.47257Z","steps":["trace[2009285952] 'process raft request' (duration: 242.911925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:17:18.472678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.877148ms","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-05-08T21:17:18.472745Z","caller":"traceutil/trace.go:171","msg":"trace[1181432887] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5347; }","duration":"134.996652ms","start":"2026-05-08T21:17:18.337733Z","end":"2026-05-08T21:17:18.47273Z","steps":["trace[1181432887] 'agreement among raft nodes before linearized reading' (duration: 134.871378ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:36.006655Z","caller":"traceutil/trace.go:171","msg":"trace[1585831608] transaction","detail":"{read_only:false; response_revision:5490; number_of_response:1; }","duration":"136.169254ms","start":"2026-05-08T21:17:35.870444Z","end":"2026-05-08T21:17:36.006613Z","steps":["trace[1585831608] 'process raft request' (duration: 36.301876ms)","trace[1585831608] 'compare' (duration: 99.62275ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:17:42.486091Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2867} {"level":"info","ts":"2026-05-08T21:17:42.5836Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2867,"took":"96.141476ms","hash":4035841136,"current-db-size-bytes":52879360,"current-db-size":"53 MB","current-db-size-in-use-bytes":28893184,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-08T21:17:42.583665Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4035841136,"revision":2867,"compact-revision":-1} {"level":"info","ts":"2026-05-08T21:17:48.099888Z","caller":"traceutil/trace.go:171","msg":"trace[1364891179] linearizableReadLoop","detail":"{readStateIndex:5777; appliedIndex:5776; }","duration":"205.070261ms","start":"2026-05-08T21:17:47.89479Z","end":"2026-05-08T21:17:48.09986Z","steps":["trace[1364891179] 'read index received' (duration: 191.47235ms)","trace[1364891179] 'applied index is now lower than readState.Index' (duration: 13.596531ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:17:48.100011Z","caller":"traceutil/trace.go:171","msg":"trace[911149026] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"230.14318ms","start":"2026-05-08T21:17:47.869854Z","end":"2026-05-08T21:17:48.099997Z","steps":["trace[911149026] 'process raft request' (duration: 216.394733ms)","trace[911149026] 'compare' (duration: 12.996208ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:17:48.100142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.911683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:17:48.100222Z","caller":"traceutil/trace.go:171","msg":"trace[57449206] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:5572; }","duration":"190.025937ms","start":"2026-05-08T21:17:47.91018Z","end":"2026-05-08T21:17:48.100206Z","steps":["trace[57449206] 'agreement among raft nodes before linearized reading' (duration: 189.887311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:17:48.100298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.477026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:17:48.100356Z","caller":"traceutil/trace.go:171","msg":"trace[1211805195] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:5572; }","duration":"205.593161ms","start":"2026-05-08T21:17:47.894751Z","end":"2026-05-08T21:17:48.100344Z","steps":["trace[1211805195] 'agreement among raft nodes before linearized reading' (duration: 205.469556ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:48.616928Z","caller":"traceutil/trace.go:171","msg":"trace[1645033840] transaction","detail":"{read_only:false; response_revision:5577; number_of_response:1; }","duration":"142.047333ms","start":"2026-05-08T21:17:48.474859Z","end":"2026-05-08T21:17:48.616906Z","steps":["trace[1645033840] 'process raft request' (duration: 141.927848ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:20:08.108116Z","caller":"traceutil/trace.go:171","msg":"trace[783577693] transaction","detail":"{read_only:false; response_revision:6514; number_of_response:1; }","duration":"175.567787ms","start":"2026-05-08T21:20:07.932521Z","end":"2026-05-08T21:20:08.108089Z","steps":["trace[783577693] 'process raft request' (duration: 175.346808ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:20:08.11324Z","caller":"traceutil/trace.go:171","msg":"trace[271379557] transaction","detail":"{read_only:false; response_revision:6515; number_of_response:1; }","duration":"179.652797ms","start":"2026-05-08T21:20:07.933554Z","end":"2026-05-08T21:20:08.113207Z","steps":["trace[271379557] 'process raft request' (duration: 179.446058ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:20:08.113356Z","caller":"traceutil/trace.go:171","msg":"trace[1528701798] linearizableReadLoop","detail":"{readStateIndex:6754; appliedIndex:6751; }","duration":"119.20374ms","start":"2026-05-08T21:20:07.994135Z","end":"2026-05-08T21:20:08.113339Z","steps":["trace[1528701798] 'read index received' (duration: 113.782083ms)","trace[1528701798] 'applied index is now lower than readState.Index' (duration: 5.420417ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:20:08.113468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.318806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:20:08.113508Z","caller":"traceutil/trace.go:171","msg":"trace[1878716155] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:6516; }","duration":"119.419389ms","start":"2026-05-08T21:20:07.994077Z","end":"2026-05-08T21:20:08.113496Z","steps":["trace[1878716155] 'agreement among raft nodes before linearized reading' (duration: 119.326295ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:20:08.113511Z","caller":"traceutil/trace.go:171","msg":"trace[241556813] transaction","detail":"{read_only:false; response_revision:6516; number_of_response:1; }","duration":"127.381559ms","start":"2026-05-08T21:20:07.986053Z","end":"2026-05-08T21:20:08.113435Z","steps":["trace[241556813] 'process raft request' (duration: 127.101037ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:20:19.139343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.396173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:20:19.139426Z","caller":"traceutil/trace.go:171","msg":"trace[608758365] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:6625; }","duration":"100.523579ms","start":"2026-05-08T21:20:19.038882Z","end":"2026-05-08T21:20:19.139406Z","steps":["trace[608758365] 'count revisions from in-memory index tree' (duration: 100.30313ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:20:21.041797Z","caller":"traceutil/trace.go:171","msg":"trace[635812050] transaction","detail":"{read_only:false; response_revision:6631; number_of_response:1; }","duration":"176.679988ms","start":"2026-05-08T21:20:20.865095Z","end":"2026-05-08T21:20:21.041775Z","steps":["trace[635812050] 'process raft request' (duration: 176.537302ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:20:21.064319Z","caller":"traceutil/trace.go:171","msg":"trace[134998607] transaction","detail":"{read_only:false; response_revision:6632; number_of_response:1; }","duration":"195.54609ms","start":"2026-05-08T21:20:20.868752Z","end":"2026-05-08T21:20:21.064298Z","steps":["trace[134998607] 'process raft request' (duration: 195.230796ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:20:21.066602Z","caller":"traceutil/trace.go:171","msg":"trace[2090959365] linearizableReadLoop","detail":"{readStateIndex:6876; appliedIndex:6873; }","duration":"148.146322ms","start":"2026-05-08T21:20:20.918326Z","end":"2026-05-08T21:20:21.066472Z","steps":["trace[2090959365] 'read index received' (duration: 123.38432ms)","trace[2090959365] 'applied index is now lower than readState.Index' (duration: 24.760672ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:20:21.066746Z","caller":"traceutil/trace.go:171","msg":"trace[1507834691] transaction","detail":"{read_only:false; response_revision:6633; number_of_response:1; }","duration":"122.069582ms","start":"2026-05-08T21:20:20.944644Z","end":"2026-05-08T21:20:21.066714Z","steps":["trace[1507834691] 'process raft request' (duration: 121.733057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:20:21.069489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.140204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-08T21:20:21.069638Z","caller":"traceutil/trace.go:171","msg":"trace[1400918036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6633; }","duration":"151.320791ms","start":"2026-05-08T21:20:20.918293Z","end":"2026-05-08T21:20:21.069614Z","steps":["trace[1400918036] 'agreement among raft nodes before linearized reading' (duration: 148.449225ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:20:29.293513Z","caller":"traceutil/trace.go:171","msg":"trace[555774350] transaction","detail":"{read_only:false; response_revision:6677; number_of_response:1; }","duration":"129.069795ms","start":"2026-05-08T21:20:29.164418Z","end":"2026-05-08T21:20:29.293488Z","steps":["trace[555774350] 'process raft request' (duration: 129.035444ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:20:29.294091Z","caller":"traceutil/trace.go:171","msg":"trace[684215954] transaction","detail":"{read_only:false; response_revision:6676; number_of_response:1; }","duration":"129.957483ms","start":"2026-05-08T21:20:29.163851Z","end":"2026-05-08T21:20:29.293809Z","steps":["trace[684215954] 'process raft request' (duration: 98.579773ms)","trace[684215954] 'compare' (duration: 30.91226ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:22:17.003376Z","caller":"traceutil/trace.go:171","msg":"trace[1225720110] transaction","detail":"{read_only:false; response_revision:7245; number_of_response:1; }","duration":"100.520482ms","start":"2026-05-08T21:22:16.90283Z","end":"2026-05-08T21:22:17.003351Z","steps":["trace[1225720110] 'process raft request' (duration: 100.397683ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:22:17.005346Z","caller":"traceutil/trace.go:171","msg":"trace[1090811736] transaction","detail":"{read_only:false; response_revision:7246; number_of_response:1; }","duration":"102.207603ms","start":"2026-05-08T21:22:16.903116Z","end":"2026-05-08T21:22:17.005323Z","steps":["trace[1090811736] 'process raft request' (duration: 102.083295ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:22:42.493213Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5522} {"level":"info","ts":"2026-05-08T21:22:42.596014Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5522,"took":"101.272315ms","hash":3167367230,"current-db-size-bytes":52879360,"current-db-size":"53 MB","current-db-size-in-use-bytes":18378752,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-08T21:22:42.596071Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3167367230,"revision":5522,"compact-revision":2867}