{"level":"warn","ts":"2026-08-11T08:22:09.427195Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T08:22:09.427363Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.108:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.108:2380","--initial-cluster=instance=https://199.19.213.108:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.108:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.108:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-11T08:22:09.427553Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T08:22:09.42758Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.108:2380"]} {"level":"info","ts":"2026-08-11T08:22:09.427614Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-11T08:22:09.428626Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"]} {"level":"info","ts":"2026-08-11T08:22:09.428763Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.108:2380"],"listen-peer-urls":["https://199.19.213.108:2380"],"advertise-client-urls":["https://199.19.213.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.108:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-11T08:22:09.434128Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.031801ms"} {"level":"info","ts":"2026-08-11T08:22:09.445348Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e9047e95cdba2056","cluster-id":"51f5e218724a48a2"} {"level":"info","ts":"2026-08-11T08:22:09.445473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T08:22:09.445505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became follower at term 0"} {"level":"info","ts":"2026-08-11T08:22:09.445517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e9047e95cdba2056 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T08:22:09.445532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became follower at term 1"} {"level":"info","ts":"2026-08-11T08:22:09.445628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=(16790684492610805846)"} {"level":"warn","ts":"2026-08-11T08:22:09.461227Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T08:22:09.463684Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T08:22:09.46476Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-11T08:22:09.468167Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e9047e95cdba2056","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T08:22:09.468425Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e9047e95cdba2056","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T08:22:09.469618Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-11T08:22:09.470038Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-11T08:22:09.470075Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-11T08:22:09.470583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=(16790684492610805846)"} {"level":"info","ts":"2026-08-11T08:22:09.470895Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"51f5e218724a48a2","local-member-id":"e9047e95cdba2056","added-peer-id":"e9047e95cdba2056","added-peer-peer-urls":["https://199.19.213.108:2380"]} {"level":"info","ts":"2026-08-11T08:22:09.478214Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-11T08:22:09.478395Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.108:2380"} {"level":"info","ts":"2026-08-11T08:22:09.478451Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.108:2380"} {"level":"info","ts":"2026-08-11T08:22:09.478528Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e9047e95cdba2056","initial-advertise-peer-urls":["https://199.19.213.108:2380"],"listen-peer-urls":["https://199.19.213.108:2380"],"advertise-client-urls":["https://199.19.213.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T08:22:09.478577Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T08:22:09.645962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T08:22:09.646035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T08:22:09.646072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 received MsgPreVoteResp from e9047e95cdba2056 at term 1"} {"level":"info","ts":"2026-08-11T08:22:09.646109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became candidate at term 2"} {"level":"info","ts":"2026-08-11T08:22:09.646126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 received MsgVoteResp from e9047e95cdba2056 at term 2"} {"level":"info","ts":"2026-08-11T08:22:09.646146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became leader at term 2"} {"level":"info","ts":"2026-08-11T08:22:09.64616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e9047e95cdba2056 elected leader e9047e95cdba2056 at term 2"} {"level":"info","ts":"2026-08-11T08:22:09.647922Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:22:09.649375Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e9047e95cdba2056","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.108:2379]}","request-path":"/0/members/e9047e95cdba2056/attributes","cluster-id":"51f5e218724a48a2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T08:22:09.649562Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:22:09.652529Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T08:22:09.652732Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:22:09.656114Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.108:2379"} {"level":"info","ts":"2026-08-11T08:22:09.656551Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"51f5e218724a48a2","local-member-id":"e9047e95cdba2056","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:22:09.656943Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:22:09.657051Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T08:22:09.657073Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T08:22:09.657094Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:22:26.637737Z","caller":"traceutil/trace.go:171","msg":"trace[1591578119] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"714.326315ms","start":"2026-08-11T08:22:25.923391Z","end":"2026-08-11T08:22:26.637717Z","steps":["trace[1591578119] 'process raft request' (duration: 714.084159ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:26.637912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.905601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:22:26.637702Z","caller":"traceutil/trace.go:171","msg":"trace[225398932] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:430; }","duration":"428.587683ms","start":"2026-08-11T08:22:26.209001Z","end":"2026-08-11T08:22:26.637588Z","steps":["trace[225398932] 'read index received' (duration: 428.393348ms)","trace[225398932] 'applied index is now lower than readState.Index' (duration: 193.325µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:22:26.63806Z","caller":"traceutil/trace.go:171","msg":"trace[1583421445] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:417; }","duration":"429.064715ms","start":"2026-08-11T08:22:26.208934Z","end":"2026-08-11T08:22:26.637999Z","steps":["trace[1583421445] 'agreement among raft nodes before linearized reading' (duration: 428.842939ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:26.638136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:26.208903Z","time spent":"429.215989ms","remote":"127.0.0.1:33416","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-08-11T08:22:26.638411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:25.923343Z","time spent":"714.453788ms","remote":"127.0.0.1:57608","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-08-11T08:22:35.14304Z","caller":"traceutil/trace.go:171","msg":"trace[465411048] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"175.126559ms","start":"2026-08-11T08:22:34.967891Z","end":"2026-08-11T08:22:35.143018Z","steps":["trace[465411048] 'process raft request' (duration: 175.055947ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:35.143065Z","caller":"traceutil/trace.go:171","msg":"trace[1595509966] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"176.824131ms","start":"2026-08-11T08:22:34.966205Z","end":"2026-08-11T08:22:35.143029Z","steps":["trace[1595509966] 'process raft request' (duration: 116.252249ms)","trace[1595509966] 'compare' (duration: 60.337697ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:22:35.143853Z","caller":"traceutil/trace.go:171","msg":"trace[243422563] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"100.386534ms","start":"2026-08-11T08:22:35.043441Z","end":"2026-08-11T08:22:35.143828Z","steps":["trace[243422563] 'process raft request' (duration: 100.217959ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:35.143945Z","caller":"traceutil/trace.go:171","msg":"trace[653533974] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"100.65738ms","start":"2026-08-11T08:22:35.043247Z","end":"2026-08-11T08:22:35.143904Z","steps":["trace[653533974] 'process raft request' (duration: 100.279131ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:35.364759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.94603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:4039"} {"level":"info","ts":"2026-08-11T08:22:35.364951Z","caller":"traceutil/trace.go:171","msg":"trace[639520215] transaction","detail":"{read_only:false; number_of_response:1; response_revision:450; }","duration":"133.997853ms","start":"2026-08-11T08:22:35.230932Z","end":"2026-08-11T08:22:35.36493Z","steps":["trace[639520215] 'process raft request' (duration: 25.649153ms)","trace[639520215] 'compare' (duration: 107.864157ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:22:35.365384Z","caller":"traceutil/trace.go:171","msg":"trace[1580038221] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"131.813238ms","start":"2026-08-11T08:22:35.23354Z","end":"2026-08-11T08:22:35.365353Z","steps":["trace[1580038221] 'process raft request' (duration: 131.333096ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:35.365432Z","caller":"traceutil/trace.go:171","msg":"trace[1414380003] linearizableReadLoop","detail":"{readStateIndex:468; appliedIndex:466; }","duration":"125.482752ms","start":"2026-08-11T08:22:35.239936Z","end":"2026-08-11T08:22:35.365419Z","steps":["trace[1414380003] 'read index received' (duration: 16.778224ms)","trace[1414380003] 'applied index is now lower than readState.Index' (duration: 108.703298ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:22:35.365556Z","caller":"traceutil/trace.go:171","msg":"trace[1350377788] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"123.570755ms","start":"2026-08-11T08:22:35.241953Z","end":"2026-08-11T08:22:35.365523Z","steps":["trace[1350377788] 'process raft request' (duration: 123.406111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:35.365595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.647357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:22:35.365641Z","caller":"traceutil/trace.go:171","msg":"trace[2047672926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:452; }","duration":"125.723988ms","start":"2026-08-11T08:22:35.239903Z","end":"2026-08-11T08:22:35.365627Z","steps":["trace[2047672926] 'agreement among raft nodes before linearized reading' (duration: 125.575485ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:35.366251Z","caller":"traceutil/trace.go:171","msg":"trace[546583417] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"120.682995ms","start":"2026-08-11T08:22:35.245553Z","end":"2026-08-11T08:22:35.366236Z","steps":["trace[546583417] 'process raft request' (duration: 120.619413ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:35.36629Z","caller":"traceutil/trace.go:171","msg":"trace[1597732279] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"123.465602ms","start":"2026-08-11T08:22:35.242811Z","end":"2026-08-11T08:22:35.366277Z","steps":["trace[1597732279] 'process raft request' (duration: 123.264347ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:48.17972Z","caller":"traceutil/trace.go:171","msg":"trace[2023354121] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"463.727223ms","start":"2026-08-11T08:22:47.715965Z","end":"2026-08-11T08:22:48.179692Z","steps":["trace[2023354121] 'process raft request' (duration: 463.493927ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.179885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.71595Z","time spent":"463.854277ms","remote":"127.0.0.1:57608","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-08-11T08:22:48.196565Z","caller":"traceutil/trace.go:171","msg":"trace[1816374948] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"440.60326ms","start":"2026-08-11T08:22:47.755886Z","end":"2026-08-11T08:22:48.19649Z","steps":["trace[1816374948] 'process raft request' (duration: 440.428005ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:48.196825Z","caller":"traceutil/trace.go:171","msg":"trace[1634496292] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"437.483775ms","start":"2026-08-11T08:22:47.759311Z","end":"2026-08-11T08:22:48.196794Z","steps":["trace[1634496292] 'process raft request' (duration: 437.108977ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:48.196867Z","caller":"traceutil/trace.go:171","msg":"trace[867270888] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"428.388361ms","start":"2026-08-11T08:22:47.768411Z","end":"2026-08-11T08:22:48.1968Z","steps":["trace[867270888] 'process raft request' (duration: 428.140736ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:48.196895Z","caller":"traceutil/trace.go:171","msg":"trace[592243441] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"436.332099ms","start":"2026-08-11T08:22:47.760537Z","end":"2026-08-11T08:22:48.196869Z","steps":["trace[592243441] 'process raft request' (duration: 435.969311ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.196932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.759301Z","time spent":"437.578987ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:22:48.196977Z","caller":"traceutil/trace.go:171","msg":"trace[1485067397] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"426.703722ms","start":"2026-08-11T08:22:47.770242Z","end":"2026-08-11T08:22:48.196945Z","steps":["trace[1485067397] 'process raft request' (duration: 426.382575ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.197012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.768398Z","time spent":"428.551296ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:22:48.197045Z","caller":"traceutil/trace.go:171","msg":"trace[1277090667] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"425.777671ms","start":"2026-08-11T08:22:47.771259Z","end":"2026-08-11T08:22:48.197037Z","steps":["trace[1277090667] 'process raft request' (duration: 425.399602ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.197085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.770218Z","time spent":"426.823626ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:22:48.19709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.771243Z","time spent":"425.828902ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:22:48.197124Z","caller":"traceutil/trace.go:171","msg":"trace[305684429] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"428.650898ms","start":"2026-08-11T08:22:47.768465Z","end":"2026-08-11T08:22:48.197116Z","steps":["trace[305684429] 'process raft request' (duration: 428.125485ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.197171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.76846Z","time spent":"428.689419ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:22:48.196996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.760528Z","time spent":"436.416521ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:22:48.197226Z","caller":"traceutil/trace.go:171","msg":"trace[521809894] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"421.325606ms","start":"2026-08-11T08:22:47.775891Z","end":"2026-08-11T08:22:48.197217Z","steps":["trace[521809894] 'process raft request' (duration: 420.833755ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.197276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.77583Z","time spent":"421.4259ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:22:48.19744Z","caller":"traceutil/trace.go:171","msg":"trace[1421949729] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"421.495411ms","start":"2026-08-11T08:22:47.775937Z","end":"2026-08-11T08:22:48.197432Z","steps":["trace[1421949729] 'process raft request' (duration: 420.944778ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.19749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.775923Z","time spent":"421.541242ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:22:48.197856Z","caller":"traceutil/trace.go:171","msg":"trace[1033004318] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:547; }","duration":"328.653193ms","start":"2026-08-11T08:22:47.869185Z","end":"2026-08-11T08:22:48.197838Z","steps":["trace[1033004318] 'read index received' (duration: 310.481978ms)","trace[1033004318] 'applied index is now lower than readState.Index' (duration: 18.170495ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:22:48.197895Z","caller":"traceutil/trace.go:171","msg":"trace[1180487976] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"408.841964ms","start":"2026-08-11T08:22:47.789046Z","end":"2026-08-11T08:22:48.197888Z","steps":["trace[1180487976] 'process raft request' (duration: 408.609408ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:48.197922Z","caller":"traceutil/trace.go:171","msg":"trace[325407933] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"274.330449ms","start":"2026-08-11T08:22:47.923586Z","end":"2026-08-11T08:22:48.197917Z","steps":["trace[325407933] 'process raft request' (duration: 274.178165ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.197944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.789023Z","time spent":"408.894635ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:22:48.198059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.875268ms","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-08-11T08:22:48.198095Z","caller":"traceutil/trace.go:171","msg":"trace[1837433968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:541; }","duration":"328.948519ms","start":"2026-08-11T08:22:47.869138Z","end":"2026-08-11T08:22:48.198087Z","steps":["trace[1837433968] 'agreement among raft nodes before linearized reading' (duration: 328.858108ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.198115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.869109Z","time spent":"329.000561ms","remote":"127.0.0.1:57608","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-08-11T08:22:48.198137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.384622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-11T08:22:48.198174Z","caller":"traceutil/trace.go:171","msg":"trace[1464630373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:541; }","duration":"324.456634ms","start":"2026-08-11T08:22:47.873708Z","end":"2026-08-11T08:22:48.198165Z","steps":["trace[1464630373] 'agreement among raft nodes before linearized reading' (duration: 324.391563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.198203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.873688Z","time spent":"324.508545ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T08:22:48.197861Z","caller":"traceutil/trace.go:171","msg":"trace[390479183] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"397.316533ms","start":"2026-08-11T08:22:47.800533Z","end":"2026-08-11T08:22:48.19785Z","steps":["trace[390479183] 'process raft request' (duration: 397.18111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:48.198325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.800507Z","time spent":"397.798393ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:22:48.198454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:47.755854Z","time spent":"440.945186ms","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:22:49.174333Z","caller":"traceutil/trace.go:171","msg":"trace[1619777414] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"107.534043ms","start":"2026-08-11T08:22:49.066779Z","end":"2026-08-11T08:22:49.174313Z","steps":["trace[1619777414] 'process raft request' (duration: 107.160324ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:49.247038Z","caller":"traceutil/trace.go:171","msg":"trace[901562551] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"148.820525ms","start":"2026-08-11T08:22:49.098194Z","end":"2026-08-11T08:22:49.247014Z","steps":["trace[901562551] 'process raft request' (duration: 131.379639ms)","trace[901562551] 'compare' (duration: 17.311973ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:22:54.24765Z","caller":"traceutil/trace.go:171","msg":"trace[1446362743] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"134.224658ms","start":"2026-08-11T08:22:54.113385Z","end":"2026-08-11T08:22:54.24761Z","steps":["trace[1446362743] 'process raft request' (duration: 133.355408ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:54.450802Z","caller":"traceutil/trace.go:171","msg":"trace[300564814] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"198.874307ms","start":"2026-08-11T08:22:54.251907Z","end":"2026-08-11T08:22:54.450782Z","steps":["trace[300564814] 'process raft request' (duration: 155.785752ms)","trace[300564814] 'compare' (duration: 43.011173ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:22:54.960863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.388573ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:22:54.961174Z","caller":"traceutil/trace.go:171","msg":"trace[990777614] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"708.379016ms","start":"2026-08-11T08:22:54.25275Z","end":"2026-08-11T08:22:54.961129Z","steps":["trace[990777614] 'process raft request' (duration: 370.624194ms)","trace[990777614] 'compare' (duration: 336.136675ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:22:54.961285Z","caller":"traceutil/trace.go:171","msg":"trace[1246073910] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:661; }","duration":"517.847029ms","start":"2026-08-11T08:22:54.44342Z","end":"2026-08-11T08:22:54.961267Z","steps":["trace[1246073910] 'read index received' (duration: 179.872932ms)","trace[1246073910] 'applied index is now lower than readState.Index' (duration: 337.973246ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:22:54.961353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:54.252729Z","time spent":"708.528148ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:22:54.961409Z","caller":"traceutil/trace.go:171","msg":"trace[152431887] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"708.229212ms","start":"2026-08-11T08:22:54.253041Z","end":"2026-08-11T08:22:54.96127Z","steps":["trace[152431887] 'process raft request' (duration: 707.939475ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:54.961497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.511784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T08:22:54.96153Z","caller":"traceutil/trace.go:171","msg":"trace[414775288] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"151.586705ms","start":"2026-08-11T08:22:54.809934Z","end":"2026-08-11T08:22:54.961521Z","steps":["trace[414775288] 'agreement among raft nodes before linearized reading' (duration: 151.478022ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:54.961562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.134105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hkkth\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-11T08:22:54.961364Z","caller":"traceutil/trace.go:171","msg":"trace[936438267] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"664.297208ms","start":"2026-08-11T08:22:54.297047Z","end":"2026-08-11T08:22:54.961345Z","steps":["trace[936438267] 'process raft request' (duration: 664.177345ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:22:54.961603Z","caller":"traceutil/trace.go:171","msg":"trace[729719733] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hkkth; range_end:; response_count:1; response_revision:639; }","duration":"518.212288ms","start":"2026-08-11T08:22:54.443379Z","end":"2026-08-11T08:22:54.961591Z","steps":["trace[729719733] 'agreement among raft nodes before linearized reading' (duration: 517.990623ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:54.961636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:54.443359Z","time spent":"518.269568ms","remote":"127.0.0.1:57526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-hkkth\" "} {"level":"warn","ts":"2026-08-11T08:22:54.96163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:54.29702Z","time spent":"664.585194ms","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:22:54.961622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:54.253032Z","time spent":"708.469767ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:22:56.031692Z","caller":"traceutil/trace.go:171","msg":"trace[802729221] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"649.897734ms","start":"2026-08-11T08:22:55.38177Z","end":"2026-08-11T08:22:56.031668Z","steps":["trace[802729221] 'process raft request' (duration: 649.223089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:22:56.031849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:55.381747Z","time spent":"650.024636ms","remote":"127.0.0.1:57438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:22:56.032011Z","caller":"traceutil/trace.go:171","msg":"trace[142909779] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"122.056619ms","start":"2026-08-11T08:22:55.909764Z","end":"2026-08-11T08:22:56.031821Z","steps":["trace[142909779] 'process raft request' (duration: 121.813563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:23:11.806391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.347064ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T08:23:11.806494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.436012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-08-11T08:23:11.806527Z","caller":"traceutil/trace.go:171","msg":"trace[1451406667] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:800; }","duration":"293.491327ms","start":"2026-08-11T08:23:11.513016Z","end":"2026-08-11T08:23:11.806507Z","steps":["trace[1451406667] 'range keys from in-memory index tree' (duration: 293.329384ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:23:11.806578Z","caller":"traceutil/trace.go:171","msg":"trace[1510790633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:800; }","duration":"675.536554ms","start":"2026-08-11T08:23:11.13102Z","end":"2026-08-11T08:23:11.806556Z","steps":["trace[1510790633] 'range keys from in-memory index tree' (duration: 675.259587ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:23:11.806624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:23:11.130948Z","time spent":"675.666017ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T08:23:11.806768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.073067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-11T08:23:11.806829Z","caller":"traceutil/trace.go:171","msg":"trace[109988082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:800; }","duration":"677.172869ms","start":"2026-08-11T08:23:11.129639Z","end":"2026-08-11T08:23:11.806812Z","steps":["trace[109988082] 'range keys from in-memory index tree' (duration: 676.931054ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:23:11.806859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:23:11.129621Z","time spent":"677.230511ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T08:23:11.806861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.089196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-8wmcc\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-11T08:23:11.806931Z","caller":"traceutil/trace.go:171","msg":"trace[1650161983] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-8wmcc; range_end:; response_count:1; response_revision:800; }","duration":"262.21187ms","start":"2026-08-11T08:23:11.544702Z","end":"2026-08-11T08:23:11.806914Z","steps":["trace[1650161983] 'range keys from in-memory index tree' (duration: 261.893603ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:23:11.807135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.680012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-11T08:23:11.807152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.979803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-11T08:23:11.807198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.835723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:23:11.80721Z","caller":"traceutil/trace.go:171","msg":"trace[13114436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:800; }","duration":"676.068846ms","start":"2026-08-11T08:23:11.131123Z","end":"2026-08-11T08:23:11.807192Z","steps":["trace[13114436] 'range keys from in-memory index tree' (duration: 675.8474ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:23:11.807185Z","caller":"traceutil/trace.go:171","msg":"trace[1077235403] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:800; }","duration":"329.873555ms","start":"2026-08-11T08:23:11.477299Z","end":"2026-08-11T08:23:11.807173Z","steps":["trace[1077235403] 'range keys from in-memory index tree' (duration: 329.445366ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:23:11.807233Z","caller":"traceutil/trace.go:171","msg":"trace[1848416672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"598.894793ms","start":"2026-08-11T08:23:11.208332Z","end":"2026-08-11T08:23:11.807227Z","steps":["trace[1848416672] 'range keys from in-memory index tree' (duration: 598.781731ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:23:11.807247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:23:11.131108Z","time spent":"676.130686ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T08:23:11.807259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:23:11.208318Z","time spent":"598.931723ms","remote":"127.0.0.1:33416","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-08-11T08:23:11.807259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:23:11.477275Z","time spent":"329.971547ms","remote":"127.0.0.1:57608","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-08-11T08:23:16.925651Z","caller":"traceutil/trace.go:171","msg":"trace[1395033084] linearizableReadLoop","detail":"{readStateIndex:892; appliedIndex:891; }","duration":"234.786246ms","start":"2026-08-11T08:23:16.690841Z","end":"2026-08-11T08:23:16.925628Z","steps":["trace[1395033084] 'read index received' (duration: 234.507871ms)","trace[1395033084] 'applied index is now lower than readState.Index' (duration: 277.215µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:23:16.925748Z","caller":"traceutil/trace.go:171","msg":"trace[1785142822] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"238.439414ms","start":"2026-08-11T08:23:16.687284Z","end":"2026-08-11T08:23:16.925724Z","steps":["trace[1785142822] 'process raft request' (duration: 238.189879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:23:16.925858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.990071ms","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-08-11T08:23:16.925922Z","caller":"traceutil/trace.go:171","msg":"trace[492187655] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:0; response_revision:861; }","duration":"235.092113ms","start":"2026-08-11T08:23:16.690809Z","end":"2026-08-11T08:23:16.925901Z","steps":["trace[492187655] 'agreement among raft nodes before linearized reading' (duration: 234.986911ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:23:17.078425Z","caller":"traceutil/trace.go:171","msg":"trace[1518299237] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"147.055038ms","start":"2026-08-11T08:23:16.931347Z","end":"2026-08-11T08:23:17.078402Z","steps":["trace[1518299237] 'process raft request' (duration: 141.878778ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:11.497854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.307628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:24:11.497958Z","caller":"traceutil/trace.go:171","msg":"trace[1489724137] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1486; }","duration":"121.472591ms","start":"2026-08-11T08:24:11.376465Z","end":"2026-08-11T08:24:11.497938Z","steps":["trace[1489724137] 'range keys from in-memory index tree' (duration: 121.224937ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:13.369844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.691226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:24:13.369958Z","caller":"traceutil/trace.go:171","msg":"trace[1865495331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1494; }","duration":"163.838781ms","start":"2026-08-11T08:24:13.206096Z","end":"2026-08-11T08:24:13.369934Z","steps":["trace[1865495331] 'range keys from in-memory index tree' (duration: 163.390581ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:13.585003Z","caller":"traceutil/trace.go:171","msg":"trace[95988694] linearizableReadLoop","detail":"{readStateIndex:1543; appliedIndex:1542; }","duration":"213.956603ms","start":"2026-08-11T08:24:13.37102Z","end":"2026-08-11T08:24:13.584977Z","steps":["trace[95988694] 'read index received' (duration: 213.828881ms)","trace[95988694] 'applied index is now lower than readState.Index' (duration: 126.492µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:24:13.585111Z","caller":"traceutil/trace.go:171","msg":"trace[1753684339] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"234.416496ms","start":"2026-08-11T08:24:13.350658Z","end":"2026-08-11T08:24:13.585074Z","steps":["trace[1753684339] 'process raft request' (duration: 234.190962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:13.585189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.148228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:24:13.585534Z","caller":"traceutil/trace.go:171","msg":"trace[938540107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1495; }","duration":"214.529304ms","start":"2026-08-11T08:24:13.370979Z","end":"2026-08-11T08:24:13.585509Z","steps":["trace[938540107] 'agreement among raft nodes before linearized reading' (duration: 214.130077ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:13.585235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.070571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.108\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-11T08:24:13.585678Z","caller":"traceutil/trace.go:171","msg":"trace[1411607294] range","detail":"{range_begin:/registry/masterleases/199.19.213.108; range_end:; response_count:1; response_revision:1495; }","duration":"180.54665ms","start":"2026-08-11T08:24:13.405096Z","end":"2026-08-11T08:24:13.585642Z","steps":["trace[1411607294] 'agreement among raft nodes before linearized reading' (duration: 180.015511ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:13.996571Z","caller":"traceutil/trace.go:171","msg":"trace[641841668] linearizableReadLoop","detail":"{readStateIndex:1544; appliedIndex:1543; }","duration":"121.118248ms","start":"2026-08-11T08:24:13.875425Z","end":"2026-08-11T08:24:13.996544Z","steps":["trace[641841668] 'read index received' (duration: 121.003576ms)","trace[641841668] 'applied index is now lower than readState.Index' (duration: 113.412µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:24:13.996704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.253462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T08:24:13.996684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:13.587422Z","time spent":"409.250068ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-11T08:24:13.996746Z","caller":"traceutil/trace.go:171","msg":"trace[1018141252] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1495; }","duration":"121.358603ms","start":"2026-08-11T08:24:13.875374Z","end":"2026-08-11T08:24:13.996733Z","steps":["trace[1018141252] 'agreement among raft nodes before linearized reading' (duration: 121.270171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:38.300871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.333789ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:24:38.300964Z","caller":"traceutil/trace.go:171","msg":"trace[247512966] linearizableReadLoop","detail":"{readStateIndex:1985; appliedIndex:1984; }","duration":"455.367488ms","start":"2026-08-11T08:24:37.845584Z","end":"2026-08-11T08:24:38.300952Z","steps":["trace[247512966] 'read index received' (duration: 281.916097ms)","trace[247512966] 'applied index is now lower than readState.Index' (duration: 173.450161ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:24:38.301129Z","caller":"traceutil/trace.go:171","msg":"trace[1470640552] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"524.511045ms","start":"2026-08-11T08:24:37.776607Z","end":"2026-08-11T08:24:38.301118Z","steps":["trace[1470640552] 'process raft request' (duration: 350.851409ms)","trace[1470640552] 'compare' (duration: 172.998113ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:24:38.30118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:37.776592Z","time spent":"524.563426ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:24:38.301356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.779206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-49fbe3d5-3e84-4446-9af1-91623ab72676\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-11T08:24:38.301382Z","caller":"traceutil/trace.go:171","msg":"trace[1730476023] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-49fbe3d5-3e84-4446-9af1-91623ab72676; range_end:; response_count:1; response_revision:1910; }","duration":"455.837036ms","start":"2026-08-11T08:24:37.845538Z","end":"2026-08-11T08:24:38.301375Z","steps":["trace[1730476023] 'agreement among raft nodes before linearized reading' (duration: 455.749874ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:38.301402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:37.845521Z","time spent":"455.876307ms","remote":"127.0.0.1:57526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-49fbe3d5-3e84-4446-9af1-91623ab72676\" "} {"level":"warn","ts":"2026-08-11T08:24:38.301573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.317717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-49fbe3d5-3e84-4446-9af1-91623ab72676\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-11T08:24:38.301604Z","caller":"traceutil/trace.go:171","msg":"trace[542413357] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-49fbe3d5-3e84-4446-9af1-91623ab72676; range_end:; response_count:1; response_revision:1910; }","duration":"366.372279ms","start":"2026-08-11T08:24:37.935221Z","end":"2026-08-11T08:24:38.301594Z","steps":["trace[542413357] 'agreement among raft nodes before linearized reading' (duration: 366.276997ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:38.301637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:37.935205Z","time spent":"366.42396ms","remote":"127.0.0.1:57526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-49fbe3d5-3e84-4446-9af1-91623ab72676\" "} {"level":"warn","ts":"2026-08-11T08:24:38.301816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.646403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:24:38.301905Z","caller":"traceutil/trace.go:171","msg":"trace[200457029] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1910; }","duration":"246.790886ms","start":"2026-08-11T08:24:38.055096Z","end":"2026-08-11T08:24:38.301887Z","steps":["trace[200457029] 'agreement among raft nodes before linearized reading' (duration: 246.643613ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:38.509437Z","caller":"traceutil/trace.go:171","msg":"trace[1541848734] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"118.639585ms","start":"2026-08-11T08:24:38.390738Z","end":"2026-08-11T08:24:38.509378Z","steps":["trace[1541848734] 'process raft request' (duration: 49.206673ms)","trace[1541848734] 'compare' (duration: 68.944862ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:24:38.930909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.485013ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T08:24:38.931007Z","caller":"traceutil/trace.go:171","msg":"trace[697572576] linearizableReadLoop","detail":"{readStateIndex:1992; appliedIndex:1991; }","duration":"167.925219ms","start":"2026-08-11T08:24:38.763058Z","end":"2026-08-11T08:24:38.930983Z","steps":["trace[697572576] 'read index received' (duration: 66.384455ms)","trace[697572576] 'applied index is now lower than readState.Index' (duration: 101.539554ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:24:38.931213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.152793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-11T08:24:38.931241Z","caller":"traceutil/trace.go:171","msg":"trace[193632895] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1916; }","duration":"168.227443ms","start":"2026-08-11T08:24:38.763005Z","end":"2026-08-11T08:24:38.931232Z","steps":["trace[193632895] 'agreement among raft nodes before linearized reading' (duration: 168.07224ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:50.546838Z","caller":"traceutil/trace.go:171","msg":"trace[1955121859] transaction","detail":"{read_only:false; response_revision:2013; number_of_response:1; }","duration":"121.866912ms","start":"2026-08-11T08:24:50.424945Z","end":"2026-08-11T08:24:50.546812Z","steps":["trace[1955121859] 'process raft request' (duration: 24.8122ms)","trace[1955121859] 'compare' (duration: 96.636344ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:24:50.990714Z","caller":"traceutil/trace.go:171","msg":"trace[2143787376] linearizableReadLoop","detail":"{readStateIndex:2094; appliedIndex:2093; }","duration":"366.842513ms","start":"2026-08-11T08:24:50.62385Z","end":"2026-08-11T08:24:50.990692Z","steps":["trace[2143787376] 'read index received' (duration: 366.598729ms)","trace[2143787376] 'applied index is now lower than readState.Index' (duration: 242.734µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:24:50.990918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.039208ms","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-08-11T08:24:50.990952Z","caller":"traceutil/trace.go:171","msg":"trace[1498478115] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"389.706498ms","start":"2026-08-11T08:24:50.601214Z","end":"2026-08-11T08:24:50.99092Z","steps":["trace[1498478115] 'process raft request' (duration: 389.329502ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:50.991071Z","caller":"traceutil/trace.go:171","msg":"trace[1772338585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2016; }","duration":"367.286742ms","start":"2026-08-11T08:24:50.623764Z","end":"2026-08-11T08:24:50.991051Z","steps":["trace[1772338585] 'agreement among raft nodes before linearized reading' (duration: 367.023937ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:50.991135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:50.623744Z","time spent":"367.373183ms","remote":"127.0.0.1:57608","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-08-11T08:24:50.991294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:50.601188Z","time spent":"389.900133ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:24:55.379782Z","caller":"traceutil/trace.go:171","msg":"trace[1016496339] linearizableReadLoop","detail":"{readStateIndex:2127; appliedIndex:2126; }","duration":"369.49046ms","start":"2026-08-11T08:24:55.010273Z","end":"2026-08-11T08:24:55.379764Z","steps":["trace[1016496339] 'read index received' (duration: 369.352878ms)","trace[1016496339] 'applied index is now lower than readState.Index' (duration: 136.612µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:24:55.379869Z","caller":"traceutil/trace.go:171","msg":"trace[450397015] transaction","detail":"{read_only:false; response_revision:2048; number_of_response:1; }","duration":"429.803957ms","start":"2026-08-11T08:24:54.950057Z","end":"2026-08-11T08:24:55.379861Z","steps":["trace[450397015] 'process raft request' (duration: 429.585883ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:55.37996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:54.949969Z","time spent":"429.921559ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:24:55.380148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.874347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T08:24:55.380176Z","caller":"traceutil/trace.go:171","msg":"trace[191951254] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2048; }","duration":"369.928618ms","start":"2026-08-11T08:24:55.010239Z","end":"2026-08-11T08:24:55.380168Z","steps":["trace[191951254] 'agreement among raft nodes before linearized reading' (duration: 369.831926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:55.380196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:55.010223Z","time spent":"369.968458ms","remote":"127.0.0.1:57608","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-08-11T08:24:55.40478Z","caller":"traceutil/trace.go:171","msg":"trace[415863721] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"163.285793ms","start":"2026-08-11T08:24:55.241468Z","end":"2026-08-11T08:24:55.404754Z","steps":["trace[415863721] 'process raft request' (duration: 163.241352ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:55.404998Z","caller":"traceutil/trace.go:171","msg":"trace[717840703] transaction","detail":"{read_only:false; response_revision:2049; number_of_response:1; }","duration":"363.677413ms","start":"2026-08-11T08:24:55.041293Z","end":"2026-08-11T08:24:55.404971Z","steps":["trace[717840703] 'process raft request' (duration: 363.290065ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:55.405026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.423566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-11T08:24:55.405121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:55.041271Z","time spent":"363.788794ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:24:55.405141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.546849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T08:24:55.405218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.960284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-11T08:24:55.405276Z","caller":"traceutil/trace.go:171","msg":"trace[74404312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2050; }","duration":"196.63352ms","start":"2026-08-11T08:24:55.208543Z","end":"2026-08-11T08:24:55.405176Z","steps":["trace[74404312] 'agreement among raft nodes before linearized reading' (duration: 196.552759ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:55.405302Z","caller":"traceutil/trace.go:171","msg":"trace[1716158382] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2050; }","duration":"205.086936ms","start":"2026-08-11T08:24:55.200199Z","end":"2026-08-11T08:24:55.405286Z","steps":["trace[1716158382] 'agreement among raft nodes before linearized reading' (duration: 204.810691ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:55.405215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.782119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-11T08:24:55.405559Z","caller":"traceutil/trace.go:171","msg":"trace[201125680] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2050; }","duration":"361.122395ms","start":"2026-08-11T08:24:55.044402Z","end":"2026-08-11T08:24:55.405524Z","steps":["trace[201125680] 'agreement among raft nodes before linearized reading' (duration: 360.646016ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:55.405666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:55.044371Z","time spent":"361.261317ms","remote":"127.0.0.1:52440","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-08-11T08:24:55.405234Z","caller":"traceutil/trace.go:171","msg":"trace[56718908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2050; }","duration":"377.513908ms","start":"2026-08-11T08:24:55.027559Z","end":"2026-08-11T08:24:55.405073Z","steps":["trace[56718908] 'agreement among raft nodes before linearized reading' (duration: 377.322004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:55.405934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:24:55.027546Z","time spent":"378.369504ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-11T08:25:17.771877Z","caller":"traceutil/trace.go:171","msg":"trace[960047590] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"244.612165ms","start":"2026-08-11T08:25:17.52724Z","end":"2026-08-11T08:25:17.771852Z","steps":["trace[960047590] 'process raft request' (duration: 196.073584ms)","trace[960047590] 'compare' (duration: 48.244619ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:25:17.771914Z","caller":"traceutil/trace.go:171","msg":"trace[363818176] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"175.762338ms","start":"2026-08-11T08:25:17.596121Z","end":"2026-08-11T08:25:17.771884Z","steps":["trace[363818176] 'process raft request' (duration: 175.668834ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:25:17.771896Z","caller":"traceutil/trace.go:171","msg":"trace[1410649626] linearizableReadLoop","detail":"{readStateIndex:2257; appliedIndex:2255; }","duration":"168.215062ms","start":"2026-08-11T08:25:17.603657Z","end":"2026-08-11T08:25:17.771872Z","steps":["trace[1410649626] 'read index received' (duration: 119.692171ms)","trace[1410649626] 'applied index is now lower than readState.Index' (duration: 48.521961ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:25:17.772154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.481972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-11T08:25:17.772193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.69534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-11T08:25:17.772229Z","caller":"traceutil/trace.go:171","msg":"trace[645445519] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2173; }","duration":"150.763472ms","start":"2026-08-11T08:25:17.621453Z","end":"2026-08-11T08:25:17.772217Z","steps":["trace[645445519] 'agreement among raft nodes before linearized reading' (duration: 150.649438ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:25:17.772229Z","caller":"traceutil/trace.go:171","msg":"trace[1035574536] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2173; }","duration":"168.653129ms","start":"2026-08-11T08:25:17.60356Z","end":"2026-08-11T08:25:17.772213Z","steps":["trace[1035574536] 'agreement among raft nodes before linearized reading' (duration: 168.42377ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:17.772193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.603576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T08:25:17.772322Z","caller":"traceutil/trace.go:171","msg":"trace[419184428] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2173; }","duration":"166.763092ms","start":"2026-08-11T08:25:17.605548Z","end":"2026-08-11T08:25:17.772311Z","steps":["trace[419184428] 'agreement among raft nodes before linearized reading' (duration: 166.544243ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:25:18.394173Z","caller":"traceutil/trace.go:171","msg":"trace[19514728] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"498.288855ms","start":"2026-08-11T08:25:17.895856Z","end":"2026-08-11T08:25:18.394145Z","steps":["trace[19514728] 'process raft request' (duration: 497.91562ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:18.394303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:25:17.895827Z","time spent":"498.4099ms","remote":"127.0.0.1:57608","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-08-11T08:25:18.405075Z","caller":"traceutil/trace.go:171","msg":"trace[1520320782] linearizableReadLoop","detail":"{readStateIndex:2261; appliedIndex:2259; }","duration":"194.128352ms","start":"2026-08-11T08:25:18.21093Z","end":"2026-08-11T08:25:18.405059Z","steps":["trace[1520320782] 'read index received' (duration: 183.022803ms)","trace[1520320782] 'applied index is now lower than readState.Index' (duration: 11.105039ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:25:18.405101Z","caller":"traceutil/trace.go:171","msg":"trace[1914133842] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"506.497226ms","start":"2026-08-11T08:25:17.898584Z","end":"2026-08-11T08:25:18.405081Z","steps":["trace[1914133842] 'process raft request' (duration: 506.38063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:18.405162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.235747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:25:18.405186Z","caller":"traceutil/trace.go:171","msg":"trace[1571980578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2177; }","duration":"194.30345ms","start":"2026-08-11T08:25:18.210876Z","end":"2026-08-11T08:25:18.40518Z","steps":["trace[1571980578] 'agreement among raft nodes before linearized reading' (duration: 194.245998ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:18.405219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:25:17.898559Z","time spent":"506.58628ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:25:18.780539Z","caller":"traceutil/trace.go:171","msg":"trace[404111500] linearizableReadLoop","detail":"{readStateIndex:2262; appliedIndex:2261; }","duration":"106.599113ms","start":"2026-08-11T08:25:18.673922Z","end":"2026-08-11T08:25:18.780521Z","steps":["trace[404111500] 'read index received' (duration: 106.53752ms)","trace[404111500] 'applied index is now lower than readState.Index' (duration: 60.913µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:25:18.780633Z","caller":"traceutil/trace.go:171","msg":"trace[1163969111] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"243.680098ms","start":"2026-08-11T08:25:18.536933Z","end":"2026-08-11T08:25:18.780614Z","steps":["trace[1163969111] 'process raft request' (duration: 243.459948ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:18.780723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.792729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T08:25:18.780762Z","caller":"traceutil/trace.go:171","msg":"trace[1255519436] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2178; }","duration":"106.880094ms","start":"2026-08-11T08:25:18.673872Z","end":"2026-08-11T08:25:18.780752Z","steps":["trace[1255519436] 'agreement among raft nodes before linearized reading' (duration: 106.756209ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:25:18.847596Z","caller":"traceutil/trace.go:171","msg":"trace[1010775655] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"165.171671ms","start":"2026-08-11T08:25:18.682401Z","end":"2026-08-11T08:25:18.847573Z","steps":["trace[1010775655] 'process raft request' (duration: 164.955482ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:19.562192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.714356ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T08:25:19.562475Z","caller":"traceutil/trace.go:171","msg":"trace[877931454] linearizableReadLoop","detail":"{readStateIndex:2264; appliedIndex:2262; }","duration":"781.854422ms","start":"2026-08-11T08:25:18.780601Z","end":"2026-08-11T08:25:19.562455Z","steps":["trace[877931454] 'read index received' (duration: 66.755701ms)","trace[877931454] 'applied index is now lower than readState.Index' (duration: 715.097651ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:25:19.562686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.383514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-11T08:25:19.562737Z","caller":"traceutil/trace.go:171","msg":"trace[751608497] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2179; }","duration":"784.470127ms","start":"2026-08-11T08:25:18.778255Z","end":"2026-08-11T08:25:19.562725Z","steps":["trace[751608497] 'agreement among raft nodes before linearized reading' (duration: 784.30952ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:19.562723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.219732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-08-11T08:25:19.562775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:25:18.778238Z","time spent":"784.52592ms","remote":"127.0.0.1:52440","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-08-11T08:25:19.562792Z","caller":"traceutil/trace.go:171","msg":"trace[820917054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2179; }","duration":"838.325766ms","start":"2026-08-11T08:25:18.724448Z","end":"2026-08-11T08:25:19.562774Z","steps":["trace[820917054] 'agreement among raft nodes before linearized reading' (duration: 838.130728ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:19.562823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:25:18.72443Z","time spent":"838.386869ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T08:25:19.562898Z","caller":"traceutil/trace.go:171","msg":"trace[334405907] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"777.007046ms","start":"2026-08-11T08:25:18.78586Z","end":"2026-08-11T08:25:19.562867Z","steps":["trace[334405907] 'process raft request' (duration: 776.458494ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:19.563087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:25:18.785834Z","time spent":"777.135891ms","remote":"127.0.0.1:57608","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-08-11T08:25:19.647982Z","caller":"traceutil/trace.go:171","msg":"trace[494337621] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"434.083483ms","start":"2026-08-11T08:25:19.213829Z","end":"2026-08-11T08:25:19.647913Z","steps":["trace[494337621] 'process raft request' (duration: 428.532468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:19.648164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:25:19.213806Z","time spent":"434.262059ms","remote":"127.0.0.1:57510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8560,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:25:19.654355Z","caller":"traceutil/trace.go:171","msg":"trace[958045520] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"125.55987ms","start":"2026-08-11T08:25:19.528765Z","end":"2026-08-11T08:25:19.654325Z","steps":["trace[958045520] 'process raft request' (duration: 125.041019ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:19.654819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.53842ms","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-08-11T08:25:19.654879Z","caller":"traceutil/trace.go:171","msg":"trace[1664063266] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2183; }","duration":"628.657773ms","start":"2026-08-11T08:25:19.026208Z","end":"2026-08-11T08:25:19.654866Z","steps":["trace[1664063266] 'agreement among raft nodes before linearized reading' (duration: 628.528578ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:19.654932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:25:19.026182Z","time spent":"628.742267ms","remote":"127.0.0.1:57762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-08-11T08:25:20.04481Z","caller":"traceutil/trace.go:171","msg":"trace[1514956452] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2268; }","duration":"235.463402ms","start":"2026-08-11T08:25:19.809305Z","end":"2026-08-11T08:25:20.044769Z","steps":["trace[1514956452] 'read index received' (duration: 203.353523ms)","trace[1514956452] 'applied index is now lower than readState.Index' (duration: 32.097629ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:25:20.044851Z","caller":"traceutil/trace.go:171","msg":"trace[2105191336] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"266.245592ms","start":"2026-08-11T08:25:19.778557Z","end":"2026-08-11T08:25:20.044803Z","steps":["trace[2105191336] 'process raft request' (duration: 234.187315ms)","trace[2105191336] 'compare' (duration: 31.697453ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:25:20.045196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.873039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T08:25:20.045244Z","caller":"traceutil/trace.go:171","msg":"trace[2062058960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2184; }","duration":"235.972702ms","start":"2026-08-11T08:25:19.809259Z","end":"2026-08-11T08:25:20.045232Z","steps":["trace[2062058960] 'agreement among raft nodes before linearized reading' (duration: 235.805035ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:20.045135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.621007ms","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-08-11T08:25:20.045307Z","caller":"traceutil/trace.go:171","msg":"trace[536430731] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2183; }","duration":"269.42393ms","start":"2026-08-11T08:25:19.775858Z","end":"2026-08-11T08:25:20.045282Z","steps":["trace[536430731] 'range keys from in-memory index tree' (duration: 268.323436ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:25:20.045607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.988408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T08:25:20.045662Z","caller":"traceutil/trace.go:171","msg":"trace[103488405] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2184; }","duration":"223.087953ms","start":"2026-08-11T08:25:19.822561Z","end":"2026-08-11T08:25:20.045649Z","steps":["trace[103488405] 'agreement among raft nodes before linearized reading' (duration: 222.884615ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:26:08.068103Z","caller":"traceutil/trace.go:171","msg":"trace[1954729126] transaction","detail":"{read_only:false; response_revision:2551; number_of_response:1; }","duration":"192.0386ms","start":"2026-08-11T08:26:07.876041Z","end":"2026-08-11T08:26:08.068079Z","steps":["trace[1954729126] 'process raft request' (duration: 191.911726ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:26:08.464278Z","caller":"traceutil/trace.go:171","msg":"trace[1188716368] linearizableReadLoop","detail":"{readStateIndex:2648; appliedIndex:2647; }","duration":"173.890079ms","start":"2026-08-11T08:26:08.290366Z","end":"2026-08-11T08:26:08.464256Z","steps":["trace[1188716368] 'read index received' (duration: 173.756675ms)","trace[1188716368] 'applied index is now lower than readState.Index' (duration: 132.034µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:26:08.464316Z","caller":"traceutil/trace.go:171","msg":"trace[745244814] transaction","detail":"{read_only:false; response_revision:2553; number_of_response:1; }","duration":"176.420026ms","start":"2026-08-11T08:26:08.287864Z","end":"2026-08-11T08:26:08.464284Z","steps":["trace[745244814] 'process raft request' (duration: 176.26991ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:26:08.464978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.589454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T08:26:08.465045Z","caller":"traceutil/trace.go:171","msg":"trace[1843478434] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2553; }","duration":"174.680406ms","start":"2026-08-11T08:26:08.290341Z","end":"2026-08-11T08:26:08.465022Z","steps":["trace[1843478434] 'agreement among raft nodes before linearized reading' (duration: 174.001303ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:26:08.697775Z","caller":"traceutil/trace.go:171","msg":"trace[128788256] linearizableReadLoop","detail":"{readStateIndex:2649; appliedIndex:2648; }","duration":"233.395633ms","start":"2026-08-11T08:26:08.464355Z","end":"2026-08-11T08:26:08.697751Z","steps":["trace[128788256] 'read index received' (duration: 209.958366ms)","trace[128788256] 'applied index is now lower than readState.Index' (duration: 23.436157ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:26:08.697916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.569177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:26:08.69795Z","caller":"traceutil/trace.go:171","msg":"trace[1390571729] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2554; }","duration":"303.671841ms","start":"2026-08-11T08:26:08.394268Z","end":"2026-08-11T08:26:08.69794Z","steps":["trace[1390571729] 'agreement among raft nodes before linearized reading' (duration: 303.572957ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:26:08.697938Z","caller":"traceutil/trace.go:171","msg":"trace[1863554076] transaction","detail":"{read_only:false; response_revision:2554; number_of_response:1; }","duration":"407.458168ms","start":"2026-08-11T08:26:08.29045Z","end":"2026-08-11T08:26:08.697908Z","steps":["trace[1863554076] 'process raft request' (duration: 383.851226ms)","trace[1863554076] 'compare' (duration: 23.333912ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:26:08.697988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:26:08.394202Z","time spent":"303.776065ms","remote":"127.0.0.1:36058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-11T08:26:08.698069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:26:08.29043Z","time spent":"407.568562ms","remote":"127.0.0.1:57608","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-08-11T08:26:08.705496Z","caller":"traceutil/trace.go:171","msg":"trace[482160384] transaction","detail":"{read_only:false; response_revision:2555; number_of_response:1; }","duration":"236.55271ms","start":"2026-08-11T08:26:08.468922Z","end":"2026-08-11T08:26:08.705474Z","steps":["trace[482160384] 'process raft request' (duration: 236.196698ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:26:08.705528Z","caller":"traceutil/trace.go:171","msg":"trace[610080790] transaction","detail":"{read_only:false; response_revision:2556; number_of_response:1; }","duration":"148.067652ms","start":"2026-08-11T08:26:08.557441Z","end":"2026-08-11T08:26:08.705508Z","steps":["trace[610080790] 'process raft request' (duration: 147.777821ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:26:41.070189Z","caller":"traceutil/trace.go:171","msg":"trace[1128926350] linearizableReadLoop","detail":"{readStateIndex:2834; appliedIndex:2833; }","duration":"228.91414ms","start":"2026-08-11T08:26:40.84125Z","end":"2026-08-11T08:26:41.070165Z","steps":["trace[1128926350] 'read index received' (duration: 228.819797ms)","trace[1128926350] 'applied index is now lower than readState.Index' (duration: 93.103µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:26:41.070279Z","caller":"traceutil/trace.go:171","msg":"trace[929036642] transaction","detail":"{read_only:false; response_revision:2731; number_of_response:1; }","duration":"253.378948ms","start":"2026-08-11T08:26:40.816872Z","end":"2026-08-11T08:26:41.070251Z","steps":["trace[929036642] 'process raft request' (duration: 253.152821ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:26:41.070497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.235519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-11T08:26:41.070572Z","caller":"traceutil/trace.go:171","msg":"trace[1409300547] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2731; }","duration":"229.354953ms","start":"2026-08-11T08:26:40.841203Z","end":"2026-08-11T08:26:41.070558Z","steps":["trace[1409300547] 'agreement among raft nodes before linearized reading' (duration: 229.049584ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:26:41.099697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.368809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T08:26:41.099796Z","caller":"traceutil/trace.go:171","msg":"trace[285739313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2732; }","duration":"258.582966ms","start":"2026-08-11T08:26:40.84119Z","end":"2026-08-11T08:26:41.099773Z","steps":["trace[285739313] 'agreement among raft nodes before linearized reading' (duration: 258.334989ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:26:46.842587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.308289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T08:26:46.842659Z","caller":"traceutil/trace.go:171","msg":"trace[1189439212] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2760; }","duration":"193.419572ms","start":"2026-08-11T08:26:46.649226Z","end":"2026-08-11T08:26:46.842646Z","steps":["trace[1189439212] 'range keys from in-memory index tree' (duration: 193.169634ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:32.494081Z","caller":"traceutil/trace.go:171","msg":"trace[1803072090] linearizableReadLoop","detail":"{readStateIndex:4826; appliedIndex:4825; }","duration":"230.928929ms","start":"2026-08-11T08:30:32.263123Z","end":"2026-08-11T08:30:32.494051Z","steps":["trace[1803072090] 'read index received' (duration: 187.046175ms)","trace[1803072090] 'applied index is now lower than readState.Index' (duration: 43.881354ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:30:32.494597Z","caller":"traceutil/trace.go:171","msg":"trace[620070282] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"296.934055ms","start":"2026-08-11T08:30:32.19764Z","end":"2026-08-11T08:30:32.494574Z","steps":["trace[620070282] 'process raft request' (duration: 252.567969ms)","trace[620070282] 'compare' (duration: 43.253581ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:30:32.494649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.055184ms","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-08-11T08:30:32.494709Z","caller":"traceutil/trace.go:171","msg":"trace[1660439007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4649; }","duration":"227.188925ms","start":"2026-08-11T08:30:32.267505Z","end":"2026-08-11T08:30:32.494694Z","steps":["trace[1660439007] 'agreement among raft nodes before linearized reading' (duration: 226.985421ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:32.494975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.921538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T08:30:32.495035Z","caller":"traceutil/trace.go:171","msg":"trace[2110030567] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4649; }","duration":"203.01962ms","start":"2026-08-11T08:30:32.291999Z","end":"2026-08-11T08:30:32.495018Z","steps":["trace[2110030567] 'agreement among raft nodes before linearized reading' (duration: 202.917897ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:32.495034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.790858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T08:30:32.495426Z","caller":"traceutil/trace.go:171","msg":"trace[210841746] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4649; }","duration":"232.236917ms","start":"2026-08-11T08:30:32.263079Z","end":"2026-08-11T08:30:32.495316Z","steps":["trace[210841746] 'agreement among raft nodes before linearized reading' (duration: 231.189784ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:38.222128Z","caller":"traceutil/trace.go:171","msg":"trace[1283850735] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"512.146368ms","start":"2026-08-11T08:30:37.709957Z","end":"2026-08-11T08:30:38.222104Z","steps":["trace[1283850735] 'process raft request' (duration: 511.978855ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:38.222278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:37.709935Z","time spent":"512.264521ms","remote":"127.0.0.1:57526","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-08-11T08:30:38.26923Z","caller":"traceutil/trace.go:171","msg":"trace[2089505335] linearizableReadLoop","detail":"{readStateIndex:4925; appliedIndex:4921; }","duration":"270.580039ms","start":"2026-08-11T08:30:37.998634Z","end":"2026-08-11T08:30:38.269214Z","steps":["trace[2089505335] 'read index received' (duration: 223.255292ms)","trace[2089505335] 'applied index is now lower than readState.Index' (duration: 47.324087ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:30:38.269321Z","caller":"traceutil/trace.go:171","msg":"trace[293498864] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"558.109427ms","start":"2026-08-11T08:30:37.711204Z","end":"2026-08-11T08:30:38.269314Z","steps":["trace[293498864] 'process raft request' (duration: 553.010693ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:38.26939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:37.711192Z","time spent":"558.145927ms","remote":"127.0.0.1:57414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":878,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:30:38.269432Z","caller":"traceutil/trace.go:171","msg":"trace[941768010] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"309.834988ms","start":"2026-08-11T08:30:37.959552Z","end":"2026-08-11T08:30:38.269387Z","steps":["trace[941768010] 'process raft request' (duration: 309.634864ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:38.26949Z","caller":"traceutil/trace.go:171","msg":"trace[2136832832] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"388.640754ms","start":"2026-08-11T08:30:37.88081Z","end":"2026-08-11T08:30:38.269451Z","steps":["trace[2136832832] 'process raft request' (duration: 388.319666ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:38.269553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.17541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T08:30:38.26962Z","caller":"traceutil/trace.go:171","msg":"trace[1595266413] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4746; }","duration":"153.293693ms","start":"2026-08-11T08:30:38.116311Z","end":"2026-08-11T08:30:38.269605Z","steps":["trace[1595266413] 'agreement among raft nodes before linearized reading' (duration: 153.17133ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:38.26967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:37.880783Z","time spent":"388.798606ms","remote":"127.0.0.1:57608","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-08-11T08:30:38.269811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.177752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-11T08:30:38.26987Z","caller":"traceutil/trace.go:171","msg":"trace[823997077] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4746; }","duration":"271.262724ms","start":"2026-08-11T08:30:37.998591Z","end":"2026-08-11T08:30:38.269853Z","steps":["trace[823997077] 'agreement among raft nodes before linearized reading' (duration: 270.987937ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:38.270243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:37.959531Z","time spent":"309.976741ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:30:38.768591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.251242ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T08:30:38.7687Z","caller":"traceutil/trace.go:171","msg":"trace[1531690864] linearizableReadLoop","detail":"{readStateIndex:4930; appliedIndex:4929; }","duration":"222.949865ms","start":"2026-08-11T08:30:38.545732Z","end":"2026-08-11T08:30:38.768681Z","steps":["trace[1531690864] 'read index received' (duration: 87.576959ms)","trace[1531690864] 'applied index is now lower than readState.Index' (duration: 135.371186ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:30:38.769166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.684449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-11T08:30:38.769232Z","caller":"traceutil/trace.go:171","msg":"trace[1134546078] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4750; }","duration":"213.790661ms","start":"2026-08-11T08:30:38.555429Z","end":"2026-08-11T08:30:38.76922Z","steps":["trace[1134546078] 'agreement among raft nodes before linearized reading' (duration: 213.597656ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:38.769476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.725842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T08:30:38.769637Z","caller":"traceutil/trace.go:171","msg":"trace[794829194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4750; }","duration":"223.897556ms","start":"2026-08-11T08:30:38.545679Z","end":"2026-08-11T08:30:38.769577Z","steps":["trace[794829194] 'agreement among raft nodes before linearized reading' (duration: 223.65066ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:43.069321Z","caller":"traceutil/trace.go:171","msg":"trace[1525658859] linearizableReadLoop","detail":"{readStateIndex:4988; appliedIndex:4987; }","duration":"236.496682ms","start":"2026-08-11T08:30:42.832802Z","end":"2026-08-11T08:30:43.069298Z","steps":["trace[1525658859] 'read index received' (duration: 236.338129ms)","trace[1525658859] 'applied index is now lower than readState.Index' (duration: 157.613µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:30:43.069592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.775838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-11T08:30:43.069447Z","caller":"traceutil/trace.go:171","msg":"trace[918301262] transaction","detail":"{read_only:false; response_revision:4807; number_of_response:1; }","duration":"237.603315ms","start":"2026-08-11T08:30:42.831812Z","end":"2026-08-11T08:30:43.069416Z","steps":["trace[918301262] 'process raft request' (duration: 237.33177ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:43.069666Z","caller":"traceutil/trace.go:171","msg":"trace[757550657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4807; }","duration":"236.89142ms","start":"2026-08-11T08:30:42.832763Z","end":"2026-08-11T08:30:43.069654Z","steps":["trace[757550657] 'agreement among raft nodes before linearized reading' (duration: 236.664165ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:43.069788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.872824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T08:30:43.069846Z","caller":"traceutil/trace.go:171","msg":"trace[1859381816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4807; }","duration":"234.003577ms","start":"2026-08-11T08:30:42.835826Z","end":"2026-08-11T08:30:43.06983Z","steps":["trace[1859381816] 'agreement among raft nodes before linearized reading' (duration: 233.823263ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:48.028709Z","caller":"traceutil/trace.go:171","msg":"trace[1418615537] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"101.680938ms","start":"2026-08-11T08:30:47.926992Z","end":"2026-08-11T08:30:48.028673Z","steps":["trace[1418615537] 'process raft request' (duration: 101.527674ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:48.028808Z","caller":"traceutil/trace.go:171","msg":"trace[719998248] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"100.950772ms","start":"2026-08-11T08:30:47.927848Z","end":"2026-08-11T08:30:48.028798Z","steps":["trace[719998248] 'process raft request' (duration: 100.745777ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:48.028744Z","caller":"traceutil/trace.go:171","msg":"trace[8220716] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"100.078973ms","start":"2026-08-11T08:30:47.928646Z","end":"2026-08-11T08:30:48.028725Z","steps":["trace[8220716] 'process raft request' (duration: 99.983861ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.404698Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2330225709985648739,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-11T08:30:53.427009Z","caller":"traceutil/trace.go:171","msg":"trace[1640140665] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"545.202289ms","start":"2026-08-11T08:30:52.881781Z","end":"2026-08-11T08:30:53.426983Z","steps":["trace[1640140665] 'process raft request' (duration: 545.026525ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.427162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:52.881758Z","time spent":"545.327093ms","remote":"127.0.0.1:57526","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-08-11T08:30:53.432512Z","caller":"traceutil/trace.go:171","msg":"trace[1852101276] linearizableReadLoop","detail":"{readStateIndex:5123; appliedIndex:5120; }","duration":"528.464792ms","start":"2026-08-11T08:30:52.904019Z","end":"2026-08-11T08:30:53.432483Z","steps":["trace[1852101276] 'read index received' (duration: 522.808898ms)","trace[1852101276] 'applied index is now lower than readState.Index' (duration: 5.654674ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:30:53.432945Z","caller":"traceutil/trace.go:171","msg":"trace[954747203] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"333.138774ms","start":"2026-08-11T08:30:53.099792Z","end":"2026-08-11T08:30:53.432931Z","steps":["trace[954747203] 'process raft request' (duration: 332.481199ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.433368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:53.099755Z","time spent":"333.243165ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:30:53.433522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.15362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T08:30:53.433609Z","caller":"traceutil/trace.go:171","msg":"trace[939496735] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:4937; }","duration":"310.292832ms","start":"2026-08-11T08:30:53.123293Z","end":"2026-08-11T08:30:53.433586Z","steps":["trace[939496735] 'agreement among raft nodes before linearized reading' (duration: 310.148089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.433655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:53.123272Z","time spent":"310.373544ms","remote":"127.0.0.1:36208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-08-11T08:30:53.433862Z","caller":"traceutil/trace.go:171","msg":"trace[1501703482] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"235.128212ms","start":"2026-08-11T08:30:53.198722Z","end":"2026-08-11T08:30:53.43385Z","steps":["trace[1501703482] 'process raft request' (duration: 233.715611ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.434051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.038308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-11T08:30:53.434089Z","caller":"traceutil/trace.go:171","msg":"trace[1978748076] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4937; }","duration":"530.124889ms","start":"2026-08-11T08:30:52.903953Z","end":"2026-08-11T08:30:53.434078Z","steps":["trace[1978748076] 'agreement among raft nodes before linearized reading' (duration: 529.997626ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.434121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:52.903928Z","time spent":"530.18254ms","remote":"127.0.0.1:57488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-08-11T08:30:53.43445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.402855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:30:53.434487Z","caller":"traceutil/trace.go:171","msg":"trace[1952166244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4937; }","duration":"228.464896ms","start":"2026-08-11T08:30:53.206013Z","end":"2026-08-11T08:30:53.434478Z","steps":["trace[1952166244] 'agreement among raft nodes before linearized reading' (duration: 228.407534ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.434665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.552652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T08:30:53.434701Z","caller":"traceutil/trace.go:171","msg":"trace[1517404040] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4937; }","duration":"277.623725ms","start":"2026-08-11T08:30:53.157069Z","end":"2026-08-11T08:30:53.434693Z","steps":["trace[1517404040] 'agreement among raft nodes before linearized reading' (duration: 277.536103ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.434816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.333375ms","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-08-11T08:30:53.434851Z","caller":"traceutil/trace.go:171","msg":"trace[1453965722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4937; }","duration":"306.438307ms","start":"2026-08-11T08:30:53.128403Z","end":"2026-08-11T08:30:53.434841Z","steps":["trace[1453965722] 'agreement among raft nodes before linearized reading' (duration: 306.360545ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.434882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:53.128377Z","time spent":"306.498178ms","remote":"127.0.0.1:57608","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-08-11T08:30:53.434981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.503368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T08:30:53.435012Z","caller":"traceutil/trace.go:171","msg":"trace[1581962467] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4937; }","duration":"306.582871ms","start":"2026-08-11T08:30:53.128422Z","end":"2026-08-11T08:30:53.435005Z","steps":["trace[1581962467] 'agreement among raft nodes before linearized reading' (duration: 306.511759ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.435038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:53.128399Z","time spent":"306.632371ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-11T08:30:53.55798Z","caller":"traceutil/trace.go:171","msg":"trace[919038325] linearizableReadLoop","detail":"{readStateIndex:5128; appliedIndex:5127; }","duration":"103.42182ms","start":"2026-08-11T08:30:53.454531Z","end":"2026-08-11T08:30:53.557953Z","steps":["trace[919038325] 'read index received' (duration: 72.798418ms)","trace[919038325] 'applied index is now lower than readState.Index' (duration: 30.622492ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:30:53.558072Z","caller":"traceutil/trace.go:171","msg":"trace[1547748834] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"115.897084ms","start":"2026-08-11T08:30:53.442118Z","end":"2026-08-11T08:30:53.558015Z","steps":["trace[1547748834] 'process raft request' (duration: 85.308772ms)","trace[1547748834] 'compare' (duration: 30.408278ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:30:53.558413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.85477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-11T08:30:53.558547Z","caller":"traceutil/trace.go:171","msg":"trace[1705303334] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4941; }","duration":"104.019712ms","start":"2026-08-11T08:30:53.454504Z","end":"2026-08-11T08:30:53.558524Z","steps":["trace[1705303334] 'agreement among raft nodes before linearized reading' (duration: 103.533552ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:53.953857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.596934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T08:30:53.953945Z","caller":"traceutil/trace.go:171","msg":"trace[2106727940] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:4946; }","duration":"154.733057ms","start":"2026-08-11T08:30:53.799188Z","end":"2026-08-11T08:30:53.953921Z","steps":["trace[2106727940] 'count revisions from in-memory index tree' (duration: 154.486911ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:54.021557Z","caller":"traceutil/trace.go:171","msg":"trace[717586118] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"212.087866ms","start":"2026-08-11T08:30:53.809443Z","end":"2026-08-11T08:30:54.021531Z","steps":["trace[717586118] 'process raft request' (duration: 211.875542ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:54.183084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.007443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:30:54.183194Z","caller":"traceutil/trace.go:171","msg":"trace[194768548] linearizableReadLoop","detail":"{readStateIndex:5135; appliedIndex:5133; }","duration":"305.908764ms","start":"2026-08-11T08:30:53.877268Z","end":"2026-08-11T08:30:54.183177Z","steps":["trace[194768548] 'read index received' (duration: 144.139455ms)","trace[194768548] 'applied index is now lower than readState.Index' (duration: 161.768109ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:30:54.183297Z","caller":"traceutil/trace.go:171","msg":"trace[1001892302] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"367.828342ms","start":"2026-08-11T08:30:53.815432Z","end":"2026-08-11T08:30:54.183261Z","steps":["trace[1001892302] 'process raft request' (duration: 257.564493ms)","trace[1001892302] 'compare' (duration: 109.887621ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:30:54.183374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:53.815412Z","time spent":"367.931955ms","remote":"127.0.0.1:57608","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-08-11T08:30:54.18349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.206069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17149"} {"level":"info","ts":"2026-08-11T08:30:54.183531Z","caller":"traceutil/trace.go:171","msg":"trace[1186446527] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4948; }","duration":"306.304322ms","start":"2026-08-11T08:30:53.877216Z","end":"2026-08-11T08:30:54.183521Z","steps":["trace[1186446527] 'agreement among raft nodes before linearized reading' (duration: 306.182059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:54.183371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.27573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"warn","ts":"2026-08-11T08:30:54.183561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:53.877193Z","time spent":"306.360913ms","remote":"127.0.0.1:57526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":17172,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-08-11T08:30:54.183588Z","caller":"traceutil/trace.go:171","msg":"trace[186958425] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4948; }","duration":"213.528265ms","start":"2026-08-11T08:30:53.970046Z","end":"2026-08-11T08:30:54.183574Z","steps":["trace[186958425] 'agreement among raft nodes before linearized reading' (duration: 213.217639ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:54.183838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.460661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:30:54.183883Z","caller":"traceutil/trace.go:171","msg":"trace[1018363105] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:4948; }","duration":"181.539413ms","start":"2026-08-11T08:30:54.002333Z","end":"2026-08-11T08:30:54.183872Z","steps":["trace[1018363105] 'agreement among raft nodes before linearized reading' (duration: 181.474003ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:32:10.226702Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2885} {"level":"info","ts":"2026-08-11T08:32:10.303831Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2885,"took":"76.05238ms","hash":1271326257,"current-db-size-bytes":54571008,"current-db-size":"55 MB","current-db-size-in-use-bytes":29229056,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-11T08:32:10.303899Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1271326257,"revision":2885,"compact-revision":-1} {"level":"info","ts":"2026-08-11T08:34:44.417304Z","caller":"traceutil/trace.go:171","msg":"trace[1889190835] transaction","detail":"{read_only:false; response_revision:6592; number_of_response:1; }","duration":"101.227236ms","start":"2026-08-11T08:34:44.316052Z","end":"2026-08-11T08:34:44.417279Z","steps":["trace[1889190835] 'process raft request' (duration: 100.998717ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:34:44.447368Z","caller":"traceutil/trace.go:171","msg":"trace[845832039] transaction","detail":"{read_only:false; response_revision:6593; number_of_response:1; }","duration":"114.641677ms","start":"2026-08-11T08:34:44.332702Z","end":"2026-08-11T08:34:44.447343Z","steps":["trace[845832039] 'process raft request' (duration: 114.481051ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:35:02.648178Z","caller":"traceutil/trace.go:171","msg":"trace[1308380172] transaction","detail":"{read_only:false; response_revision:6736; number_of_response:1; }","duration":"165.946912ms","start":"2026-08-11T08:35:02.482211Z","end":"2026-08-11T08:35:02.648158Z","steps":["trace[1308380172] 'process raft request' (duration: 165.772976ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:35:02.680392Z","caller":"traceutil/trace.go:171","msg":"trace[1984093236] transaction","detail":"{read_only:false; response_revision:6737; number_of_response:1; }","duration":"158.839198ms","start":"2026-08-11T08:35:02.521529Z","end":"2026-08-11T08:35:02.680368Z","steps":["trace[1984093236] 'process raft request' (duration: 158.33541ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:37:10.234314Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5560} {"level":"info","ts":"2026-08-11T08:37:10.355976Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5560,"took":"120.154986ms","hash":2907056097,"current-db-size-bytes":54571008,"current-db-size":"55 MB","current-db-size-in-use-bytes":18391040,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-11T08:37:10.356031Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2907056097,"revision":5560,"compact-revision":2885}