{"level":"warn","ts":"2026-08-11T07:25:40.43899Z","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-11T07:25:40.439069Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.74: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.74:2380","--initial-cluster=instance=https://199.19.213.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.74: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-11T07:25:40.439133Z","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-11T07:25:40.439156Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.74:2380"]} {"level":"info","ts":"2026-08-11T07:25:40.439176Z","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-11T07:25:40.439792Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.74:2379"]} {"level":"info","ts":"2026-08-11T07:25:40.439867Z","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.74:2380"],"listen-peer-urls":["https://199.19.213.74:2380"],"advertise-client-urls":["https://199.19.213.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.74: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-11T07:25:40.448571Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.436291ms"} {"level":"info","ts":"2026-08-11T07:25:40.465531Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d4171f3ea72ed207","cluster-id":"d40b55e346dc63dc"} {"level":"info","ts":"2026-08-11T07:25:40.465629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T07:25:40.465654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 became follower at term 0"} {"level":"info","ts":"2026-08-11T07:25:40.46567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d4171f3ea72ed207 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T07:25:40.465679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 became follower at term 1"} {"level":"info","ts":"2026-08-11T07:25:40.465727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 switched to configuration voters=(15282718214458364423)"} {"level":"warn","ts":"2026-08-11T07:25:40.476193Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T07:25:40.477569Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T07:25:40.478695Z","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-11T07:25:40.482771Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d4171f3ea72ed207","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T07:25:40.482946Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d4171f3ea72ed207","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T07:25:40.483189Z","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-11T07:25:40.483266Z","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-11T07:25:40.483279Z","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-11T07:25:40.487778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 switched to configuration voters=(15282718214458364423)"} {"level":"info","ts":"2026-08-11T07:25:40.488072Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d40b55e346dc63dc","local-member-id":"d4171f3ea72ed207","added-peer-id":"d4171f3ea72ed207","added-peer-peer-urls":["https://199.19.213.74:2380"]} {"level":"info","ts":"2026-08-11T07:25:40.489662Z","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-11T07:25:40.489905Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d4171f3ea72ed207","initial-advertise-peer-urls":["https://199.19.213.74:2380"],"listen-peer-urls":["https://199.19.213.74:2380"],"advertise-client-urls":["https://199.19.213.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T07:25:40.48995Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T07:25:40.490091Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.74:2380"} {"level":"info","ts":"2026-08-11T07:25:40.490115Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.74:2380"} {"level":"info","ts":"2026-08-11T07:25:41.466132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T07:25:41.466215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T07:25:41.466256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 received MsgPreVoteResp from d4171f3ea72ed207 at term 1"} {"level":"info","ts":"2026-08-11T07:25:41.466279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 became candidate at term 2"} {"level":"info","ts":"2026-08-11T07:25:41.466291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 received MsgVoteResp from d4171f3ea72ed207 at term 2"} {"level":"info","ts":"2026-08-11T07:25:41.466307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d4171f3ea72ed207 became leader at term 2"} {"level":"info","ts":"2026-08-11T07:25:41.466321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d4171f3ea72ed207 elected leader d4171f3ea72ed207 at term 2"} {"level":"info","ts":"2026-08-11T07:25:41.467359Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d4171f3ea72ed207","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.74:2379]}","request-path":"/0/members/d4171f3ea72ed207/attributes","cluster-id":"d40b55e346dc63dc","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T07:25:41.467362Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T07:25:41.467388Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:25:41.467578Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T07:25:41.467715Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T07:25:41.467812Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T07:25:41.468849Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d40b55e346dc63dc","local-member-id":"d4171f3ea72ed207","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:25:41.468985Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:25:41.469111Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:25:41.471562Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T07:25:41.471634Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.74:2379"} {"level":"info","ts":"2026-08-11T07:25:44.00545Z","caller":"traceutil/trace.go:171","msg":"trace[81530155] linearizableReadLoop","detail":"{readStateIndex:119; appliedIndex:118; }","duration":"108.977084ms","start":"2026-08-11T07:25:43.896442Z","end":"2026-08-11T07:25:44.005419Z","steps":["trace[81530155] 'read index received' (duration: 108.747618ms)","trace[81530155] 'applied index is now lower than readState.Index' (duration: 228.066µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:25:44.005565Z","caller":"traceutil/trace.go:171","msg":"trace[1258149871] transaction","detail":"{read_only:false; response_revision:114; number_of_response:1; }","duration":"192.736517ms","start":"2026-08-11T07:25:43.81278Z","end":"2026-08-11T07:25:44.005516Z","steps":["trace[1258149871] 'process raft request' (duration: 192.48218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:25:44.0057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.23443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-11T07:25:44.005793Z","caller":"traceutil/trace.go:171","msg":"trace[941060252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:114; }","duration":"109.390843ms","start":"2026-08-11T07:25:43.896383Z","end":"2026-08-11T07:25:44.005774Z","steps":["trace[941060252] 'agreement among raft nodes before linearized reading' (duration: 109.187389ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:25:45.119879Z","caller":"traceutil/trace.go:171","msg":"trace[1855185012] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"182.174591ms","start":"2026-08-11T07:25:44.937683Z","end":"2026-08-11T07:25:45.119858Z","steps":["trace[1855185012] 'process raft request' (duration: 182.052918ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:25:55.757853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.110209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:25:55.758Z","caller":"traceutil/trace.go:171","msg":"trace[413864822] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"825.930496ms","start":"2026-08-11T07:25:54.932039Z","end":"2026-08-11T07:25:55.757969Z","steps":["trace[413864822] 'process raft request' (duration: 261.942301ms)","trace[413864822] 'compare' (duration: 562.895955ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:25:55.758042Z","caller":"traceutil/trace.go:171","msg":"trace[1575566017] linearizableReadLoop","detail":"{readStateIndex:412; appliedIndex:411; }","duration":"256.683445ms","start":"2026-08-11T07:25:55.501285Z","end":"2026-08-11T07:25:55.757969Z","steps":["trace[1575566017] 'read index received' (duration: 59.701µs)","trace[1575566017] 'applied index is now lower than readState.Index' (duration: 256.622114ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:25:55.758186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:25:54.932016Z","time spent":"826.065129ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:25:55.758239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.92173ms","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-11T07:25:55.758363Z","caller":"traceutil/trace.go:171","msg":"trace[2062768048] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:400; }","duration":"257.134975ms","start":"2026-08-11T07:25:55.501204Z","end":"2026-08-11T07:25:55.758339Z","steps":["trace[2062768048] 'agreement among raft nodes before linearized reading' (duration: 256.870399ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:25:56.200057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.021818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:25:56.200197Z","caller":"traceutil/trace.go:171","msg":"trace[1702816070] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"436.760794ms","start":"2026-08-11T07:25:55.763408Z","end":"2026-08-11T07:25:56.200169Z","steps":["trace[1702816070] 'process raft request' (duration: 239.519101ms)","trace[1702816070] 'compare' (duration: 196.869856ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:25:56.20027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:25:55.763379Z","time spent":"436.856775ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:26:21.615407Z","caller":"traceutil/trace.go:171","msg":"trace[303495964] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"306.199365ms","start":"2026-08-11T07:26:21.309178Z","end":"2026-08-11T07:26:21.615378Z","steps":["trace[303495964] 'process raft request' (duration: 305.993322ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:21.61564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:21.30915Z","time spent":"306.384518ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:26:21.634738Z","caller":"traceutil/trace.go:171","msg":"trace[1666598475] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"313.634031ms","start":"2026-08-11T07:26:21.32106Z","end":"2026-08-11T07:26:21.634694Z","steps":["trace[1666598475] 'process raft request' (duration: 313.493659ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:26:21.634956Z","caller":"traceutil/trace.go:171","msg":"trace[137225906] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"309.017549ms","start":"2026-08-11T07:26:21.325926Z","end":"2026-08-11T07:26:21.634944Z","steps":["trace[137225906] 'process raft request' (duration: 308.877037ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:26:21.635065Z","caller":"traceutil/trace.go:171","msg":"trace[373052873] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"266.708431ms","start":"2026-08-11T07:26:21.368348Z","end":"2026-08-11T07:26:21.635057Z","steps":["trace[373052873] 'process raft request' (duration: 266.602779ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:26:21.634994Z","caller":"traceutil/trace.go:171","msg":"trace[526146692] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"309.619329ms","start":"2026-08-11T07:26:21.325272Z","end":"2026-08-11T07:26:21.634891Z","steps":["trace[526146692] 'process raft request' (duration: 309.368005ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:21.635154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:21.32592Z","time spent":"309.151741ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:26:21.635215Z","caller":"traceutil/trace.go:171","msg":"trace[316471612] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"262.628507ms","start":"2026-08-11T07:26:21.372571Z","end":"2026-08-11T07:26:21.635199Z","steps":["trace[316471612] 'process raft request' (duration: 262.435694ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:21.634976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:21.321048Z","time spent":"313.826154ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T07:26:21.635276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:21.325264Z","time spent":"309.892663ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:26:21.635347Z","caller":"traceutil/trace.go:171","msg":"trace[1174066229] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"255.755911ms","start":"2026-08-11T07:26:21.37958Z","end":"2026-08-11T07:26:21.635336Z","steps":["trace[1174066229] 'process raft request' (duration: 255.528226ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:26:21.634765Z","caller":"traceutil/trace.go:171","msg":"trace[2005918688] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"312.324311ms","start":"2026-08-11T07:26:21.322398Z","end":"2026-08-11T07:26:21.634722Z","steps":["trace[2005918688] 'process raft request' (duration: 312.196239ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:21.635435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:21.322374Z","time spent":"313.018003ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:26:21.634797Z","caller":"traceutil/trace.go:171","msg":"trace[364596285] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"317.526762ms","start":"2026-08-11T07:26:21.317244Z","end":"2026-08-11T07:26:21.634771Z","steps":["trace[364596285] 'process raft request' (duration: 317.086286ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:21.635548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:21.31722Z","time spent":"318.291214ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:26:21.635028Z","caller":"traceutil/trace.go:171","msg":"trace[334212243] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"308.801816ms","start":"2026-08-11T07:26:21.326215Z","end":"2026-08-11T07:26:21.635017Z","steps":["trace[334212243] 'process raft request' (duration: 308.684274ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:26:21.635127Z","caller":"traceutil/trace.go:171","msg":"trace[2084348945] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"317.822657ms","start":"2026-08-11T07:26:21.317244Z","end":"2026-08-11T07:26:21.635066Z","steps":["trace[2084348945] 'process raft request' (duration: 317.233008ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:21.635706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:21.317216Z","time spent":"318.447047ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:26:21.635539Z","caller":"traceutil/trace.go:171","msg":"trace[814102421] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"127.22052ms","start":"2026-08-11T07:26:21.508281Z","end":"2026-08-11T07:26:21.635501Z","steps":["trace[814102421] 'process raft request' (duration: 127.089558ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:21.635844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:21.326209Z","time spent":"309.459487ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:26:28.069529Z","caller":"traceutil/trace.go:171","msg":"trace[1472447988] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"129.498109ms","start":"2026-08-11T07:26:27.93999Z","end":"2026-08-11T07:26:28.069488Z","steps":["trace[1472447988] 'read index received' (duration: 129.249645ms)","trace[1472447988] 'applied index is now lower than readState.Index' (duration: 247.334µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:26:28.069612Z","caller":"traceutil/trace.go:171","msg":"trace[1430167384] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"171.522343ms","start":"2026-08-11T07:26:27.898065Z","end":"2026-08-11T07:26:28.069588Z","steps":["trace[1430167384] 'process raft request' (duration: 171.118197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:28.069782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.764652ms","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-11T07:26:28.069862Z","caller":"traceutil/trace.go:171","msg":"trace[627719367] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"129.868153ms","start":"2026-08-11T07:26:27.939946Z","end":"2026-08-11T07:26:28.069814Z","steps":["trace[627719367] 'agreement among raft nodes before linearized reading' (duration: 129.686881ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:26:28.143044Z","caller":"traceutil/trace.go:171","msg":"trace[352158738] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"178.566599ms","start":"2026-08-11T07:26:27.964442Z","end":"2026-08-11T07:26:28.143009Z","steps":["trace[352158738] 'process raft request' (duration: 177.815959ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:28.371651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.901553ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:26:28.371988Z","caller":"traceutil/trace.go:171","msg":"trace[958636036] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"295.557332ms","start":"2026-08-11T07:26:28.076379Z","end":"2026-08-11T07:26:28.371937Z","steps":["trace[958636036] 'process raft request' (duration: 143.255433ms)","trace[958636036] 'compare' (duration: 151.522947ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:26:28.372117Z","caller":"traceutil/trace.go:171","msg":"trace[767435626] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"169.34348ms","start":"2026-08-11T07:26:28.202736Z","end":"2026-08-11T07:26:28.37208Z","steps":["trace[767435626] 'process raft request' (duration: 169.131187ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:29.482313Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15134240924709090888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:26:29.982564Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15134240924709090888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:26:30.483359Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15134240924709090888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:26:30.669914Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.780730293s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T07:26:30.671324Z","caller":"traceutil/trace.go:171","msg":"trace[1420148398] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.783378662s","start":"2026-08-11T07:26:28.887919Z","end":"2026-08-11T07:26:30.671298Z","steps":["trace[1420148398] 'process raft request' (duration: 1.782554341s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:30.671792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:28.887881Z","time spent":"1.783526795s","remote":"127.0.0.1:52230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:26:30.770019Z","caller":"traceutil/trace.go:171","msg":"trace[165856227] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:659; }","duration":"1.788353485s","start":"2026-08-11T07:26:28.981587Z","end":"2026-08-11T07:26:30.769941Z","steps":["trace[165856227] 'read index received' (duration: 1.688564442s)","trace[165856227] 'applied index is now lower than readState.Index' (duration: 99.784373ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:26:30.770553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.654311ms","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-11T07:26:30.770684Z","caller":"traceutil/trace.go:171","msg":"trace[793156947] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:642; }","duration":"392.839414ms","start":"2026-08-11T07:26:30.377829Z","end":"2026-08-11T07:26:30.770669Z","steps":["trace[793156947] 'agreement among raft nodes before linearized reading' (duration: 392.59519ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:30.770757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:30.377805Z","time spent":"392.942805ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T07:26:30.770801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.607822277s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T07:26:30.770598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.069966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-11T07:26:30.770797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.632889264s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-11T07:26:30.77091Z","caller":"traceutil/trace.go:171","msg":"trace[1768886019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"1.607993699s","start":"2026-08-11T07:26:29.162889Z","end":"2026-08-11T07:26:30.770883Z","steps":["trace[1768886019] 'agreement among raft nodes before linearized reading' (duration: 1.607813866s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:30.770962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:29.16286Z","time spent":"1.608094061s","remote":"127.0.0.1:52132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-11T07:26:30.770922Z","caller":"traceutil/trace.go:171","msg":"trace[1059717047] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:642; }","duration":"296.403251ms","start":"2026-08-11T07:26:30.474492Z","end":"2026-08-11T07:26:30.770896Z","steps":["trace[1059717047] 'agreement among raft nodes before linearized reading' (duration: 295.933544ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:26:30.771012Z","caller":"traceutil/trace.go:171","msg":"trace[1828325553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"1.633221349s","start":"2026-08-11T07:26:29.137721Z","end":"2026-08-11T07:26:30.770942Z","steps":["trace[1828325553] 'agreement among raft nodes before linearized reading' (duration: 1.632725522s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:30.771199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.789554682s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:26:30.771408Z","caller":"traceutil/trace.go:171","msg":"trace[830205322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"1.789873868s","start":"2026-08-11T07:26:28.981504Z","end":"2026-08-11T07:26:30.771378Z","steps":["trace[830205322] 'agreement among raft nodes before linearized reading' (duration: 1.788635449s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:30.771164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:29.137693Z","time spent":"1.633455131s","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T07:26:30.771536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:28.981472Z","time spent":"1.790019099s","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-11T07:26:32.379604Z","caller":"traceutil/trace.go:171","msg":"trace[1210031543] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"332.383486ms","start":"2026-08-11T07:26:32.047199Z","end":"2026-08-11T07:26:32.379582Z","steps":["trace[1210031543] 'process raft request' (duration: 332.231524ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:32.379762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:32.047184Z","time spent":"332.489147ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:26:32.403502Z","caller":"traceutil/trace.go:171","msg":"trace[2051881609] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:694; }","duration":"241.145817ms","start":"2026-08-11T07:26:32.162326Z","end":"2026-08-11T07:26:32.403471Z","steps":["trace[2051881609] 'read index received' (duration: 217.173634ms)","trace[2051881609] 'applied index is now lower than readState.Index' (duration: 23.970723ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:26:32.403559Z","caller":"traceutil/trace.go:171","msg":"trace[900301310] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"353.860403ms","start":"2026-08-11T07:26:32.049657Z","end":"2026-08-11T07:26:32.403518Z","steps":["trace[900301310] 'process raft request' (duration: 353.59929ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:26:32.403619Z","caller":"traceutil/trace.go:171","msg":"trace[354403190] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"203.886773ms","start":"2026-08-11T07:26:32.199688Z","end":"2026-08-11T07:26:32.403575Z","steps":["trace[354403190] 'process raft request' (duration: 203.732151ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:32.403734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:26:32.403815Z","caller":"traceutil/trace.go:171","msg":"trace[1561186899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"241.544754ms","start":"2026-08-11T07:26:32.162248Z","end":"2026-08-11T07:26:32.403792Z","steps":["trace[1561186899] 'agreement among raft nodes before linearized reading' (duration: 241.390861ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:32.4037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:26:32.049648Z","time spent":"353.971594ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:26:46.24857Z","caller":"traceutil/trace.go:171","msg":"trace[318198446] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:826; }","duration":"221.230659ms","start":"2026-08-11T07:26:46.027314Z","end":"2026-08-11T07:26:46.248545Z","steps":["trace[318198446] 'read index received' (duration: 220.499139ms)","trace[318198446] 'applied index is now lower than readState.Index' (duration: 730.26µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:26:46.249092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.627644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T07:26:46.249272Z","caller":"traceutil/trace.go:171","msg":"trace[1259804924] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:802; }","duration":"221.983909ms","start":"2026-08-11T07:26:46.027248Z","end":"2026-08-11T07:26:46.249232Z","steps":["trace[1259804924] 'agreement among raft nodes before linearized reading' (duration: 221.603054ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:26:46.249296Z","caller":"traceutil/trace.go:171","msg":"trace[1843717567] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"233.417677ms","start":"2026-08-11T07:26:46.015842Z","end":"2026-08-11T07:26:46.24926Z","steps":["trace[1843717567] 'process raft request' (duration: 232.533156ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:26:46.249178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.069101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-11T07:26:46.249948Z","caller":"traceutil/trace.go:171","msg":"trace[1314094649] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:802; }","duration":"157.516467ms","start":"2026-08-11T07:26:46.092075Z","end":"2026-08-11T07:26:46.249592Z","steps":["trace[1314094649] 'agreement among raft nodes before linearized reading' (duration: 156.908279ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:19.349251Z","caller":"traceutil/trace.go:171","msg":"trace[675123249] linearizableReadLoop","detail":"{readStateIndex:1251; appliedIndex:1250; }","duration":"243.623197ms","start":"2026-08-11T07:27:19.105604Z","end":"2026-08-11T07:27:19.349228Z","steps":["trace[675123249] 'read index received' (duration: 243.381935ms)","trace[675123249] 'applied index is now lower than readState.Index' (duration: 240.262µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:27:19.349377Z","caller":"traceutil/trace.go:171","msg":"trace[1824875877] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"259.054087ms","start":"2026-08-11T07:27:19.090313Z","end":"2026-08-11T07:27:19.349367Z","steps":["trace[1824875877] 'process raft request' (duration: 258.753484ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:19.349643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.894598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-11T07:27:19.349736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.117353ms","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-11T07:27:19.349779Z","caller":"traceutil/trace.go:171","msg":"trace[1116574210] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1218; }","duration":"244.215304ms","start":"2026-08-11T07:27:19.105551Z","end":"2026-08-11T07:27:19.349767Z","steps":["trace[1116574210] 'agreement among raft nodes before linearized reading' (duration: 244.067362ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:19.349792Z","caller":"traceutil/trace.go:171","msg":"trace[1887281548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1218; }","duration":"231.082631ms","start":"2026-08-11T07:27:19.118659Z","end":"2026-08-11T07:27:19.349742Z","steps":["trace[1887281548] 'agreement among raft nodes before linearized reading' (duration: 230.823698ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:19.349863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.056111ms","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-11T07:27:19.349978Z","caller":"traceutil/trace.go:171","msg":"trace[506889814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1218; }","duration":"231.238693ms","start":"2026-08-11T07:27:19.118714Z","end":"2026-08-11T07:27:19.349953Z","steps":["trace[506889814] 'agreement among raft nodes before linearized reading' (duration: 230.886968ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:19.349708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.535764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:19.350689Z","caller":"traceutil/trace.go:171","msg":"trace[683125786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1218; }","duration":"189.10987ms","start":"2026-08-11T07:27:19.161086Z","end":"2026-08-11T07:27:19.350196Z","steps":["trace[683125786] 'agreement among raft nodes before linearized reading' (duration: 188.489103ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:45.646135Z","caller":"traceutil/trace.go:171","msg":"trace[439775603] linearizableReadLoop","detail":"{readStateIndex:1536; appliedIndex:1535; }","duration":"120.651346ms","start":"2026-08-11T07:27:45.525459Z","end":"2026-08-11T07:27:45.64611Z","steps":["trace[439775603] 'read index received' (duration: 120.392293ms)","trace[439775603] 'applied index is now lower than readState.Index' (duration: 257.793µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:27:45.646277Z","caller":"traceutil/trace.go:171","msg":"trace[1312384713] transaction","detail":"{read_only:false; response_revision:1492; number_of_response:1; }","duration":"128.242142ms","start":"2026-08-11T07:27:45.517987Z","end":"2026-08-11T07:27:45.646229Z","steps":["trace[1312384713] 'process raft request' (duration: 127.949229ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:45.646448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.973458ms","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-11T07:27:45.646495Z","caller":"traceutil/trace.go:171","msg":"trace[1570218804] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1492; }","duration":"121.075ms","start":"2026-08-11T07:27:45.525406Z","end":"2026-08-11T07:27:45.646481Z","steps":["trace[1570218804] 'agreement among raft nodes before linearized reading' (duration: 120.866628ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:12.814601Z","caller":"traceutil/trace.go:171","msg":"trace[419024255] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"338.417794ms","start":"2026-08-11T07:28:12.476154Z","end":"2026-08-11T07:28:12.814572Z","steps":["trace[419024255] 'process raft request' (duration: 338.210442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:12.814882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:12.476133Z","time spent":"338.572405ms","remote":"127.0.0.1:52294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:28:13.102688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.1967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:28:13.102938Z","caller":"traceutil/trace.go:171","msg":"trace[1138745985] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"115.031786ms","start":"2026-08-11T07:28:12.987885Z","end":"2026-08-11T07:28:13.102917Z","steps":["trace[1138745985] 'process raft request' (duration: 114.985866ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:13.103037Z","caller":"traceutil/trace.go:171","msg":"trace[1233605567] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"577.692714ms","start":"2026-08-11T07:28:12.525316Z","end":"2026-08-11T07:28:13.103009Z","steps":["trace[1233605567] 'process raft request' (duration: 440.06233ms)","trace[1233605567] 'compare' (duration: 137.058409ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:13.103171Z","caller":"traceutil/trace.go:171","msg":"trace[1702684393] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"537.058219ms","start":"2026-08-11T07:28:12.566099Z","end":"2026-08-11T07:28:13.103157Z","steps":["trace[1702684393] 'process raft request' (duration: 536.702996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:13.103211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:12.52528Z","time spent":"577.833645ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:28:13.103242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:12.566073Z","time spent":"537.13198ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:28:13.103338Z","caller":"traceutil/trace.go:171","msg":"trace[293966171] linearizableReadLoop","detail":"{readStateIndex:1997; appliedIndex:1994; }","duration":"357.6407ms","start":"2026-08-11T07:28:12.745687Z","end":"2026-08-11T07:28:13.103328Z","steps":["trace[293966171] 'read index received' (duration: 68.715852ms)","trace[293966171] 'applied index is now lower than readState.Index' (duration: 288.923728ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:28:13.103558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.886971ms","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-11T07:28:13.103593Z","caller":"traceutil/trace.go:171","msg":"trace[1015510007] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1927; }","duration":"357.983823ms","start":"2026-08-11T07:28:12.7456Z","end":"2026-08-11T07:28:13.103584Z","steps":["trace[1015510007] 'agreement among raft nodes before linearized reading' (duration: 357.814201ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:13.103624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:12.745566Z","time spent":"358.051343ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-11T07:28:13.103691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.571024ms","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-11T07:28:13.103754Z","caller":"traceutil/trace.go:171","msg":"trace[11733070] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1927; }","duration":"274.673395ms","start":"2026-08-11T07:28:12.829064Z","end":"2026-08-11T07:28:13.103737Z","steps":["trace[11733070] 'agreement among raft nodes before linearized reading' (duration: 274.481773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:13.529203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.898169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-27a9db26-81dd-485b-92c3-5d8fbd8dd4f1\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-08-11T07:28:13.529258Z","caller":"traceutil/trace.go:171","msg":"trace[1240850530] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"139.135648ms","start":"2026-08-11T07:28:13.390069Z","end":"2026-08-11T07:28:13.529204Z","steps":["trace[1240850530] 'process raft request' (duration: 84.687269ms)","trace[1240850530] 'compare' (duration: 53.855013ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:13.529305Z","caller":"traceutil/trace.go:171","msg":"trace[1593500762] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-27a9db26-81dd-485b-92c3-5d8fbd8dd4f1; range_end:; response_count:1; response_revision:1928; }","duration":"307.11377ms","start":"2026-08-11T07:28:13.222168Z","end":"2026-08-11T07:28:13.529281Z","steps":["trace[1593500762] 'range keys from in-memory index tree' (duration: 306.662067ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:13.529368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:13.222141Z","time spent":"307.216811ms","remote":"127.0.0.1:52294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3767,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-27a9db26-81dd-485b-92c3-5d8fbd8dd4f1\" "} {"level":"info","ts":"2026-08-11T07:28:25.775789Z","caller":"traceutil/trace.go:171","msg":"trace[703479664] transaction","detail":"{read_only:false; response_revision:2031; number_of_response:1; }","duration":"195.860683ms","start":"2026-08-11T07:28:25.579894Z","end":"2026-08-11T07:28:25.775755Z","steps":["trace[703479664] 'process raft request' (duration: 173.475792ms)","trace[703479664] 'compare' (duration: 22.097998ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:26.197516Z","caller":"traceutil/trace.go:171","msg":"trace[853842637] linearizableReadLoop","detail":"{readStateIndex:2107; appliedIndex:2106; }","duration":"292.990951ms","start":"2026-08-11T07:28:25.90448Z","end":"2026-08-11T07:28:26.197471Z","steps":["trace[853842637] 'read index received' (duration: 292.724418ms)","trace[853842637] 'applied index is now lower than readState.Index' (duration: 265.133µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:26.197533Z","caller":"traceutil/trace.go:171","msg":"trace[1216225789] transaction","detail":"{read_only:false; response_revision:2032; number_of_response:1; }","duration":"329.510167ms","start":"2026-08-11T07:28:25.867986Z","end":"2026-08-11T07:28:26.197496Z","steps":["trace[1216225789] 'process raft request' (duration: 329.280055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:26.197731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:25.867954Z","time spent":"329.667698ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:28:26.197793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.305973ms","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-11T07:28:26.197832Z","caller":"traceutil/trace.go:171","msg":"trace[554481198] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2032; }","duration":"293.417914ms","start":"2026-08-11T07:28:25.9044Z","end":"2026-08-11T07:28:26.197818Z","steps":["trace[554481198] 'agreement among raft nodes before linearized reading' (duration: 293.234352ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:26.198199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.842938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11978"} {"level":"info","ts":"2026-08-11T07:28:26.198305Z","caller":"traceutil/trace.go:171","msg":"trace[213941503] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2032; }","duration":"217.02292ms","start":"2026-08-11T07:28:25.981253Z","end":"2026-08-11T07:28:26.198276Z","steps":["trace[213941503] 'agreement among raft nodes before linearized reading' (duration: 216.720597ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:26.198408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.636797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-btfp6\" ","response":"range_response_count:1 size:5854"} {"level":"warn","ts":"2026-08-11T07:28:26.19845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.019413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:28:26.198467Z","caller":"traceutil/trace.go:171","msg":"trace[1056337080] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-btfp6; range_end:; response_count:1; response_revision:2032; }","duration":"243.741449ms","start":"2026-08-11T07:28:25.954708Z","end":"2026-08-11T07:28:26.198449Z","steps":["trace[1056337080] 'agreement among raft nodes before linearized reading' (duration: 243.532157ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:26.198501Z","caller":"traceutil/trace.go:171","msg":"trace[784216505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2032; }","duration":"290.080343ms","start":"2026-08-11T07:28:25.908406Z","end":"2026-08-11T07:28:26.198487Z","steps":["trace[784216505] 'agreement among raft nodes before linearized reading' (duration: 289.968722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:26.198633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.347726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:28:26.198662Z","caller":"traceutil/trace.go:171","msg":"trace[60768586] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2032; }","duration":"290.394897ms","start":"2026-08-11T07:28:25.908257Z","end":"2026-08-11T07:28:26.198652Z","steps":["trace[60768586] 'agreement among raft nodes before linearized reading' (duration: 289.630739ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:26.447951Z","caller":"traceutil/trace.go:171","msg":"trace[781743023] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"243.491296ms","start":"2026-08-11T07:28:26.204419Z","end":"2026-08-11T07:28:26.44791Z","steps":["trace[781743023] 'process raft request' (duration: 167.975401ms)","trace[781743023] 'compare' (duration: 75.359703ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:26.678282Z","caller":"traceutil/trace.go:171","msg":"trace[1494957069] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"473.492331ms","start":"2026-08-11T07:28:26.204741Z","end":"2026-08-11T07:28:26.678234Z","steps":["trace[1494957069] 'process raft request' (duration: 390.093895ms)","trace[1494957069] 'compare' (duration: 82.466477ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:26.678753Z","caller":"traceutil/trace.go:171","msg":"trace[2116333929] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"240.239276ms","start":"2026-08-11T07:28:26.438483Z","end":"2026-08-11T07:28:26.678722Z","steps":["trace[2116333929] 'process raft request' (duration: 240.145905ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:26.678923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.600528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:28:26.678978Z","caller":"traceutil/trace.go:171","msg":"trace[864269725] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2037; }","duration":"467.69986ms","start":"2026-08-11T07:28:26.211269Z","end":"2026-08-11T07:28:26.678969Z","steps":["trace[864269725] 'agreement among raft nodes before linearized reading' (duration: 467.544788ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:26.679024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:26.21126Z","time spent":"467.75523ms","remote":"127.0.0.1:52536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-08-11T07:28:26.678785Z","caller":"traceutil/trace.go:171","msg":"trace[2084416950] linearizableReadLoop","detail":"{readStateIndex:2111; appliedIndex:2107; }","duration":"467.473256ms","start":"2026-08-11T07:28:26.211296Z","end":"2026-08-11T07:28:26.67877Z","steps":["trace[2084416950] 'read index received' (duration: 161.272081ms)","trace[2084416950] 'applied index is now lower than readState.Index' (duration: 306.199205ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:28:26.678766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:26.204653Z","time spent":"473.949435ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:28:26.678415Z","caller":"traceutil/trace.go:171","msg":"trace[712786619] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"473.39495ms","start":"2026-08-11T07:28:26.204977Z","end":"2026-08-11T07:28:26.678372Z","steps":["trace[712786619] 'process raft request' (duration: 472.522083ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:26.679432Z","caller":"traceutil/trace.go:171","msg":"trace[2051798884] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"469.172183ms","start":"2026-08-11T07:28:26.209578Z","end":"2026-08-11T07:28:26.67875Z","steps":["trace[2051798884] 'process raft request' (duration: 468.689969ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:26.679479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:26.20494Z","time spent":"474.476491ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:28:26.680172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:26.209549Z","time spent":"470.469975ms","remote":"127.0.0.1:52294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5625,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:28:26.859047Z","caller":"traceutil/trace.go:171","msg":"trace[521509469] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"169.120201ms","start":"2026-08-11T07:28:26.689888Z","end":"2026-08-11T07:28:26.859008Z","steps":["trace[521509469] 'process raft request' (duration: 158.538967ms)","trace[521509469] 'compare' (duration: 10.386143ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:26.85936Z","caller":"traceutil/trace.go:171","msg":"trace[1329350685] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"163.960715ms","start":"2026-08-11T07:28:26.695379Z","end":"2026-08-11T07:28:26.859339Z","steps":["trace[1329350685] 'process raft request' (duration: 163.554942ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:26.859495Z","caller":"traceutil/trace.go:171","msg":"trace[852200343] linearizableReadLoop","detail":"{readStateIndex:2115; appliedIndex:2112; }","duration":"159.921709ms","start":"2026-08-11T07:28:26.699553Z","end":"2026-08-11T07:28:26.859475Z","steps":["trace[852200343] 'read index received' (duration: 11.561064ms)","trace[852200343] 'applied index is now lower than readState.Index' (duration: 148.359165ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:28:26.859716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.153332ms","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-11T07:28:26.859744Z","caller":"traceutil/trace.go:171","msg":"trace[1310606343] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2040; }","duration":"160.241972ms","start":"2026-08-11T07:28:26.699491Z","end":"2026-08-11T07:28:26.859733Z","steps":["trace[1310606343] 'agreement among raft nodes before linearized reading' (duration: 160.098221ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:26.86133Z","caller":"traceutil/trace.go:171","msg":"trace[906891506] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"132.504514ms","start":"2026-08-11T07:28:26.728801Z","end":"2026-08-11T07:28:26.861306Z","steps":["trace[906891506] 'process raft request' (duration: 130.178373ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:29.90051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.346929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:28:29.900614Z","caller":"traceutil/trace.go:171","msg":"trace[97018663] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2063; }","duration":"282.532631ms","start":"2026-08-11T07:28:29.618058Z","end":"2026-08-11T07:28:29.900591Z","steps":["trace[97018663] 'count revisions from in-memory index tree' (duration: 282.166458ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:29.900775Z","caller":"traceutil/trace.go:171","msg":"trace[2085183748] linearizableReadLoop","detail":"{readStateIndex:2139; appliedIndex:2138; }","duration":"132.162775ms","start":"2026-08-11T07:28:29.768565Z","end":"2026-08-11T07:28:29.900728Z","steps":["trace[2085183748] 'read index received' (duration: 126.693897ms)","trace[2085183748] 'applied index is now lower than readState.Index' (duration: 5.467658ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:28:29.900956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.372827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:28:29.900991Z","caller":"traceutil/trace.go:171","msg":"trace[1173167784] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2064; }","duration":"132.476277ms","start":"2026-08-11T07:28:29.768504Z","end":"2026-08-11T07:28:29.90098Z","steps":["trace[1173167784] 'agreement among raft nodes before linearized reading' (duration: 132.338286ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:29.901172Z","caller":"traceutil/trace.go:171","msg":"trace[817985347] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"204.452767ms","start":"2026-08-11T07:28:29.696711Z","end":"2026-08-11T07:28:29.901164Z","steps":["trace[817985347] 'process raft request' (duration: 198.589575ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:29.912806Z","caller":"traceutil/trace.go:171","msg":"trace[658166062] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"120.890794ms","start":"2026-08-11T07:28:29.791845Z","end":"2026-08-11T07:28:29.912735Z","steps":["trace[658166062] 'process raft request' (duration: 120.671913ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:30.299173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.424539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:28:30.299519Z","caller":"traceutil/trace.go:171","msg":"trace[612480764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2065; }","duration":"137.664761ms","start":"2026-08-11T07:28:30.161683Z","end":"2026-08-11T07:28:30.299347Z","steps":["trace[612480764] 'range keys from in-memory index tree' (duration: 137.310218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:52.778638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.592467ms","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-11T07:28:52.778734Z","caller":"traceutil/trace.go:171","msg":"trace[403483039] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2189; }","duration":"175.748468ms","start":"2026-08-11T07:28:52.602967Z","end":"2026-08-11T07:28:52.778715Z","steps":["trace[403483039] 'range keys from in-memory index tree' (duration: 174.965191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:53.221929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.925328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:28:53.222031Z","caller":"traceutil/trace.go:171","msg":"trace[1885295295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2190; }","duration":"322.08699ms","start":"2026-08-11T07:28:52.899918Z","end":"2026-08-11T07:28:53.222005Z","steps":["trace[1885295295] 'range keys from in-memory index tree' (duration: 321.720647ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:53.222077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:52.899894Z","time spent":"322.172841ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T07:28:53.222849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.96678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:28:53.222939Z","caller":"traceutil/trace.go:171","msg":"trace[1712852417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2190; }","duration":"314.114921ms","start":"2026-08-11T07:28:52.908804Z","end":"2026-08-11T07:28:53.222919Z","steps":["trace[1712852417] 'range keys from in-memory index tree' (duration: 313.045321ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:53.222978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:52.908771Z","time spent":"314.198402ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T07:28:53.346017Z","caller":"traceutil/trace.go:171","msg":"trace[1920704553] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"119.116589ms","start":"2026-08-11T07:28:53.226863Z","end":"2026-08-11T07:28:53.34598Z","steps":["trace[1920704553] 'process raft request' (duration: 118.880747ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:53.36109Z","caller":"traceutil/trace.go:171","msg":"trace[950886889] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"133.912607ms","start":"2026-08-11T07:28:53.22714Z","end":"2026-08-11T07:28:53.361053Z","steps":["trace[950886889] 'process raft request' (duration: 133.671694ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:53.529665Z","caller":"traceutil/trace.go:171","msg":"trace[1933170319] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"107.050626ms","start":"2026-08-11T07:28:53.422565Z","end":"2026-08-11T07:28:53.529615Z","steps":["trace[1933170319] 'process raft request' (duration: 102.386927ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:53.8475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.878885ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:28:53.847599Z","caller":"traceutil/trace.go:171","msg":"trace[343604064] linearizableReadLoop","detail":"{readStateIndex:2275; appliedIndex:2273; }","duration":"416.8282ms","start":"2026-08-11T07:28:53.430756Z","end":"2026-08-11T07:28:53.847584Z","steps":["trace[343604064] 'read index received' (duration: 94.187057ms)","trace[343604064] 'applied index is now lower than readState.Index' (duration: 322.639913ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:53.847666Z","caller":"traceutil/trace.go:171","msg":"trace[822695458] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"420.046418ms","start":"2026-08-11T07:28:53.427605Z","end":"2026-08-11T07:28:53.847652Z","steps":["trace[822695458] 'process raft request' (duration: 291.925271ms)","trace[822695458] 'compare' (duration: 127.579673ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:28:53.847706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.961151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T07:28:53.847732Z","caller":"traceutil/trace.go:171","msg":"trace[384731038] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2194; }","duration":"417.032962ms","start":"2026-08-11T07:28:53.430693Z","end":"2026-08-11T07:28:53.847726Z","steps":["trace[384731038] 'agreement among raft nodes before linearized reading' (duration: 416.971732ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:53.847735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:53.427593Z","time spent":"420.111028ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:28:53.847756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:53.430662Z","time spent":"417.087423ms","remote":"127.0.0.1:52556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:28:53.847839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.786377ms","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-11T07:28:53.847919Z","caller":"traceutil/trace.go:171","msg":"trace[193595377] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2194; }","duration":"341.872488ms","start":"2026-08-11T07:28:53.506023Z","end":"2026-08-11T07:28:53.847896Z","steps":["trace[193595377] 'agreement among raft nodes before linearized reading' (duration: 341.673426ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:53.847947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:53.505944Z","time spent":"341.998099ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-11T07:28:53.848132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.539927ms","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-11T07:28:53.848176Z","caller":"traceutil/trace.go:171","msg":"trace[276077597] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2194; }","duration":"325.663549ms","start":"2026-08-11T07:28:53.522491Z","end":"2026-08-11T07:28:53.848154Z","steps":["trace[276077597] 'agreement among raft nodes before linearized reading' (duration: 325.564508ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:53.848201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:53.522466Z","time spent":"325.73081ms","remote":"127.0.0.1:38166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-11T07:28:54.319495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.925305ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:28:54.319617Z","caller":"traceutil/trace.go:171","msg":"trace[1819502165] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"310.457246ms","start":"2026-08-11T07:28:54.009138Z","end":"2026-08-11T07:28:54.319596Z","steps":["trace[1819502165] 'process raft request' (duration: 106.121518ms)","trace[1819502165] 'compare' (duration: 203.766734ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:28:54.319724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:54.009104Z","time spent":"310.558257ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:28:54.669933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.481627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-11T07:28:54.669971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.969202ms","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-11T07:28:54.670029Z","caller":"traceutil/trace.go:171","msg":"trace[1338084215] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2197; }","duration":"184.623858ms","start":"2026-08-11T07:28:54.48538Z","end":"2026-08-11T07:28:54.670004Z","steps":["trace[1338084215] 'count revisions from in-memory index tree' (duration: 184.341856ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:54.670074Z","caller":"traceutil/trace.go:171","msg":"trace[1521227949] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2197; }","duration":"233.126934ms","start":"2026-08-11T07:28:54.436919Z","end":"2026-08-11T07:28:54.670046Z","steps":["trace[1521227949] 'range keys from in-memory index tree' (duration: 232.7526ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:54.842605Z","caller":"traceutil/trace.go:171","msg":"trace[2034120585] linearizableReadLoop","detail":"{readStateIndex:2279; appliedIndex:2278; }","duration":"128.917383ms","start":"2026-08-11T07:28:54.713666Z","end":"2026-08-11T07:28:54.842584Z","steps":["trace[2034120585] 'read index received' (duration: 128.690721ms)","trace[2034120585] 'applied index is now lower than readState.Index' (duration: 225.652µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:54.842698Z","caller":"traceutil/trace.go:171","msg":"trace[1589634964] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"168.049878ms","start":"2026-08-11T07:28:54.674603Z","end":"2026-08-11T07:28:54.842653Z","steps":["trace[1589634964] 'process raft request' (duration: 167.830676ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:54.842958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.269026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-11T07:28:54.84303Z","caller":"traceutil/trace.go:171","msg":"trace[1476609391] range","detail":"{range_begin:/registry/masterleases/199.19.213.74; range_end:; response_count:1; response_revision:2198; }","duration":"129.398016ms","start":"2026-08-11T07:28:54.713614Z","end":"2026-08-11T07:28:54.843012Z","steps":["trace[1476609391] 'agreement among raft nodes before linearized reading' (duration: 129.048324ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:55.133987Z","caller":"traceutil/trace.go:171","msg":"trace[338517204] linearizableReadLoop","detail":"{readStateIndex:2281; appliedIndex:2279; }","duration":"279.925412ms","start":"2026-08-11T07:28:54.854037Z","end":"2026-08-11T07:28:55.133963Z","steps":["trace[338517204] 'read index received' (duration: 222.780494ms)","trace[338517204] 'applied index is now lower than readState.Index' (duration: 57.143788ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:55.134055Z","caller":"traceutil/trace.go:171","msg":"trace[1138464962] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"286.466429ms","start":"2026-08-11T07:28:54.847548Z","end":"2026-08-11T07:28:55.134014Z","steps":["trace[1138464962] 'process raft request' (duration: 286.277807ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:55.134344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.279985ms","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-11T07:28:55.134428Z","caller":"traceutil/trace.go:171","msg":"trace[1465748645] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2199; }","duration":"280.395827ms","start":"2026-08-11T07:28:54.854012Z","end":"2026-08-11T07:28:55.134408Z","steps":["trace[1465748645] 'agreement among raft nodes before linearized reading' (duration: 280.193155ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:55.134502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.113298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:28:55.135347Z","caller":"traceutil/trace.go:171","msg":"trace[1369044180] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2199; }","duration":"167.3728ms","start":"2026-08-11T07:28:54.967289Z","end":"2026-08-11T07:28:55.134662Z","steps":["trace[1369044180] 'agreement among raft nodes before linearized reading' (duration: 167.079098ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:55.456213Z","caller":"traceutil/trace.go:171","msg":"trace[789007123] linearizableReadLoop","detail":"{readStateIndex:2283; appliedIndex:2282; }","duration":"105.38868ms","start":"2026-08-11T07:28:55.35079Z","end":"2026-08-11T07:28:55.456179Z","steps":["trace[789007123] 'read index received' (duration: 103.848187ms)","trace[789007123] 'applied index is now lower than readState.Index' (duration: 1.538583ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:28:55.456545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.733643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:28:55.456592Z","caller":"traceutil/trace.go:171","msg":"trace[838232327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2201; }","duration":"105.843623ms","start":"2026-08-11T07:28:55.350733Z","end":"2026-08-11T07:28:55.456576Z","steps":["trace[838232327] 'agreement among raft nodes before linearized reading' (duration: 105.616772ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:55.456562Z","caller":"traceutil/trace.go:171","msg":"trace[638394875] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"278.58054ms","start":"2026-08-11T07:28:55.177753Z","end":"2026-08-11T07:28:55.456333Z","steps":["trace[638394875] 'process raft request' (duration: 276.872406ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:32.656537Z","caller":"traceutil/trace.go:171","msg":"trace[61915620] transaction","detail":"{read_only:false; response_revision:2398; number_of_response:1; }","duration":"134.276945ms","start":"2026-08-11T07:29:32.522233Z","end":"2026-08-11T07:29:32.65651Z","steps":["trace[61915620] 'process raft request' (duration: 134.095989ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:15.381682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.674366ms","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-11T07:30:15.381771Z","caller":"traceutil/trace.go:171","msg":"trace[1485109197] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2676; }","duration":"100.81234ms","start":"2026-08-11T07:30:15.280941Z","end":"2026-08-11T07:30:15.381753Z","steps":["trace[1485109197] 'range keys from in-memory index tree' (duration: 100.491472ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:24.561876Z","caller":"traceutil/trace.go:171","msg":"trace[102508705] transaction","detail":"{read_only:false; response_revision:2778; number_of_response:1; }","duration":"124.677407ms","start":"2026-08-11T07:30:24.437163Z","end":"2026-08-11T07:30:24.561841Z","steps":["trace[102508705] 'process raft request' (duration: 119.96403ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:25.630427Z","caller":"traceutil/trace.go:171","msg":"trace[1848262919] linearizableReadLoop","detail":"{readStateIndex:2883; appliedIndex:2882; }","duration":"154.950182ms","start":"2026-08-11T07:30:25.475419Z","end":"2026-08-11T07:30:25.630369Z","steps":["trace[1848262919] 'read index received' (duration: 154.787866ms)","trace[1848262919] 'applied index is now lower than readState.Index' (duration: 161.066µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:30:25.630519Z","caller":"traceutil/trace.go:171","msg":"trace[603886073] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"197.705797ms","start":"2026-08-11T07:30:25.43278Z","end":"2026-08-11T07:30:25.630485Z","steps":["trace[603886073] 'process raft request' (duration: 197.423968ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:25.630631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.199888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:30:25.630672Z","caller":"traceutil/trace.go:171","msg":"trace[1372722625] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2781; }","duration":"155.301762ms","start":"2026-08-11T07:30:25.475358Z","end":"2026-08-11T07:30:25.63066Z","steps":["trace[1372722625] 'agreement among raft nodes before linearized reading' (duration: 155.164258ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:25.635101Z","caller":"traceutil/trace.go:171","msg":"trace[1511571304] transaction","detail":"{read_only:false; response_revision:2782; number_of_response:1; }","duration":"125.534415ms","start":"2026-08-11T07:30:25.509536Z","end":"2026-08-11T07:30:25.635071Z","steps":["trace[1511571304] 'process raft request' (duration: 125.322999ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:39.87734Z","caller":"traceutil/trace.go:171","msg":"trace[115933170] transaction","detail":"{read_only:false; response_revision:2864; number_of_response:1; }","duration":"178.685214ms","start":"2026-08-11T07:30:39.698618Z","end":"2026-08-11T07:30:39.877303Z","steps":["trace[115933170] 'process raft request' (duration: 148.430968ms)","trace[115933170] 'compare' (duration: 29.995669ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:30:40.385301Z","caller":"traceutil/trace.go:171","msg":"trace[1944719476] transaction","detail":"{read_only:false; response_revision:2868; number_of_response:1; }","duration":"104.893378ms","start":"2026-08-11T07:30:40.280382Z","end":"2026-08-11T07:30:40.385276Z","steps":["trace[1944719476] 'process raft request' (duration: 79.773266ms)","trace[1944719476] 'compare' (duration: 25.02297ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:30:56.934982Z","caller":"traceutil/trace.go:171","msg":"trace[1488563031] linearizableReadLoop","detail":"{readStateIndex:3062; appliedIndex:3061; }","duration":"459.157353ms","start":"2026-08-11T07:30:56.4758Z","end":"2026-08-11T07:30:56.934957Z","steps":["trace[1488563031] 'read index received' (duration: 458.918656ms)","trace[1488563031] 'applied index is now lower than readState.Index' (duration: 237.697µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:30:56.935163Z","caller":"traceutil/trace.go:171","msg":"trace[120842796] transaction","detail":"{read_only:false; response_revision:2954; number_of_response:1; }","duration":"490.061225ms","start":"2026-08-11T07:30:56.445081Z","end":"2026-08-11T07:30:56.935142Z","steps":["trace[120842796] 'process raft request' (duration: 489.638273ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:56.935379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.512282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-11T07:30:56.935459Z","caller":"traceutil/trace.go:171","msg":"trace[2072016024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2954; }","duration":"459.698986ms","start":"2026-08-11T07:30:56.475746Z","end":"2026-08-11T07:30:56.935445Z","steps":["trace[2072016024] 'agreement among raft nodes before linearized reading' (duration: 459.42784ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:56.935548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:56.475724Z","time spent":"459.81182ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T07:30:56.935626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:56.445059Z","time spent":"490.26952ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:30:57.388842Z","caller":"traceutil/trace.go:171","msg":"trace[1081148575] linearizableReadLoop","detail":"{readStateIndex:3063; appliedIndex:3062; }","duration":"453.671012ms","start":"2026-08-11T07:30:56.935141Z","end":"2026-08-11T07:30:57.388813Z","steps":["trace[1081148575] 'read index received' (duration: 434.9329ms)","trace[1081148575] 'applied index is now lower than readState.Index' (duration: 18.736492ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:30:57.388947Z","caller":"traceutil/trace.go:171","msg":"trace[658618776] transaction","detail":"{read_only:false; response_revision:2955; number_of_response:1; }","duration":"626.013982ms","start":"2026-08-11T07:30:56.76289Z","end":"2026-08-11T07:30:57.388904Z","steps":["trace[658618776] 'process raft request' (duration: 607.173707ms)","trace[658618776] 'compare' (duration: 18.398474ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:30:57.389125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.031322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-08-11T07:30:57.389229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:56.762838Z","time spent":"626.302999ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:30:57.389249Z","caller":"traceutil/trace.go:171","msg":"trace[463615415] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2955; }","duration":"800.194147ms","start":"2026-08-11T07:30:56.589029Z","end":"2026-08-11T07:30:57.389223Z","steps":["trace[463615415] 'agreement among raft nodes before linearized reading' (duration: 799.882779ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:57.389325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:56.589008Z","time spent":"800.29774ms","remote":"127.0.0.1:52308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1393,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-08-11T07:30:57.389671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.72992ms","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-11T07:30:57.390008Z","caller":"traceutil/trace.go:171","msg":"trace[1265964491] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2955; }","duration":"816.12245ms","start":"2026-08-11T07:30:56.573872Z","end":"2026-08-11T07:30:57.389995Z","steps":["trace[1265964491] 'agreement among raft nodes before linearized reading' (duration: 815.127445ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:57.390129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:56.573853Z","time spent":"816.264173ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-11T07:30:57.437418Z","caller":"traceutil/trace.go:171","msg":"trace[778122611] transaction","detail":"{read_only:false; response_revision:2958; number_of_response:1; }","duration":"418.371946ms","start":"2026-08-11T07:30:57.019017Z","end":"2026-08-11T07:30:57.437389Z","steps":["trace[778122611] 'process raft request' (duration: 418.265262ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:57.437623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:57.019003Z","time spent":"418.50793ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:30:57.438187Z","caller":"traceutil/trace.go:171","msg":"trace[2026729772] transaction","detail":"{read_only:false; response_revision:2956; number_of_response:1; }","duration":"489.987156ms","start":"2026-08-11T07:30:56.948181Z","end":"2026-08-11T07:30:57.438168Z","steps":["trace[2026729772] 'process raft request' (duration: 488.849107ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:57.438283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:56.948164Z","time spent":"490.071218ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:30:57.438491Z","caller":"traceutil/trace.go:171","msg":"trace[45814490] transaction","detail":"{read_only:false; response_revision:2957; number_of_response:1; }","duration":"429.454415ms","start":"2026-08-11T07:30:57.009016Z","end":"2026-08-11T07:30:57.438471Z","steps":["trace[45814490] 'process raft request' (duration: 428.204203ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:57.438618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:57.008959Z","time spent":"429.612149ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:30:57.439526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.260938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:30:57.439593Z","caller":"traceutil/trace.go:171","msg":"trace[1841076128] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2958; }","duration":"280.368391ms","start":"2026-08-11T07:30:57.159208Z","end":"2026-08-11T07:30:57.439576Z","steps":["trace[1841076128] 'agreement among raft nodes before linearized reading' (duration: 280.267388ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:31:03.012987Z","caller":"traceutil/trace.go:171","msg":"trace[1466827369] transaction","detail":"{read_only:false; response_revision:2986; number_of_response:1; }","duration":"129.136004ms","start":"2026-08-11T07:31:02.883822Z","end":"2026-08-11T07:31:03.012958Z","steps":["trace[1466827369] 'process raft request' (duration: 128.861496ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:31:07.607055Z","caller":"traceutil/trace.go:171","msg":"trace[1042406814] transaction","detail":"{read_only:false; response_revision:3011; number_of_response:1; }","duration":"109.154626ms","start":"2026-08-11T07:31:07.497869Z","end":"2026-08-11T07:31:07.607024Z","steps":["trace[1042406814] 'process raft request' (duration: 51.263487ms)","trace[1042406814] 'compare' (duration: 57.750685ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:31:35.719909Z","caller":"traceutil/trace.go:171","msg":"trace[1730918309] transaction","detail":"{read_only:false; response_revision:3158; number_of_response:1; }","duration":"126.23565ms","start":"2026-08-11T07:31:35.593638Z","end":"2026-08-11T07:31:35.719874Z","steps":["trace[1730918309] 'process raft request' (duration: 125.960905ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:31:43.959017Z","caller":"traceutil/trace.go:171","msg":"trace[1735858454] transaction","detail":"{read_only:false; response_revision:3202; number_of_response:1; }","duration":"121.078385ms","start":"2026-08-11T07:31:43.837914Z","end":"2026-08-11T07:31:43.958992Z","steps":["trace[1735858454] 'process raft request' (duration: 38.304825ms)","trace[1735858454] 'compare' (duration: 82.602026ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:31:43.959864Z","caller":"traceutil/trace.go:171","msg":"trace[1648482745] transaction","detail":"{read_only:false; response_revision:3203; number_of_response:1; }","duration":"121.363571ms","start":"2026-08-11T07:31:43.838461Z","end":"2026-08-11T07:31:43.959824Z","steps":["trace[1648482745] 'process raft request' (duration: 120.488442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:31:44.548026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.166117ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:31:44.548237Z","caller":"traceutil/trace.go:171","msg":"trace[1005624154] transaction","detail":"{read_only:false; response_revision:3206; number_of_response:1; }","duration":"161.064052ms","start":"2026-08-11T07:31:44.387153Z","end":"2026-08-11T07:31:44.548217Z","steps":["trace[1005624154] 'process raft request' (duration: 18.62413ms)","trace[1005624154] 'compare' (duration: 141.804678ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:32:06.276793Z","caller":"traceutil/trace.go:171","msg":"trace[1856931378] linearizableReadLoop","detail":"{readStateIndex:3440; appliedIndex:3439; }","duration":"120.534871ms","start":"2026-08-11T07:32:06.156195Z","end":"2026-08-11T07:32:06.27673Z","steps":["trace[1856931378] 'read index received' (duration: 120.252045ms)","trace[1856931378] 'applied index is now lower than readState.Index' (duration: 281.766µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:32:06.276947Z","caller":"traceutil/trace.go:171","msg":"trace[1445301225] transaction","detail":"{read_only:false; response_revision:3317; number_of_response:1; }","duration":"127.754682ms","start":"2026-08-11T07:32:06.149137Z","end":"2026-08-11T07:32:06.276892Z","steps":["trace[1445301225] 'process raft request' (duration: 127.387134ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:32:06.277076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.862038ms","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-11T07:32:06.2772Z","caller":"traceutil/trace.go:171","msg":"trace[224009626] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3317; }","duration":"121.051732ms","start":"2026-08-11T07:32:06.156128Z","end":"2026-08-11T07:32:06.27718Z","steps":["trace[224009626] 'agreement among raft nodes before linearized reading' (duration: 120.782917ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:13.39719Z","caller":"traceutil/trace.go:171","msg":"trace[82429334] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"187.459485ms","start":"2026-08-11T07:35:13.209695Z","end":"2026-08-11T07:35:13.397154Z","steps":["trace[82429334] 'process raft request' (duration: 154.466097ms)","trace[82429334] 'compare' (duration: 32.823366ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:13.478094Z","caller":"traceutil/trace.go:171","msg":"trace[360065711] linearizableReadLoop","detail":"{readStateIndex:5105; appliedIndex:5104; }","duration":"112.097756ms","start":"2026-08-11T07:35:13.365966Z","end":"2026-08-11T07:35:13.478063Z","steps":["trace[360065711] 'read index received' (duration: 111.921013ms)","trace[360065711] 'applied index is now lower than readState.Index' (duration: 175.633µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:13.478145Z","caller":"traceutil/trace.go:171","msg":"trace[194555765] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"211.616706ms","start":"2026-08-11T07:35:13.266508Z","end":"2026-08-11T07:35:13.478125Z","steps":["trace[194555765] 'process raft request' (duration: 211.402062ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:13.478363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.382279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-11T07:35:13.478399Z","caller":"traceutil/trace.go:171","msg":"trace[1329660493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4919; }","duration":"112.488702ms","start":"2026-08-11T07:35:13.365898Z","end":"2026-08-11T07:35:13.478387Z","steps":["trace[1329660493] 'agreement among raft nodes before linearized reading' (duration: 112.29186ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:13.625827Z","caller":"traceutil/trace.go:171","msg":"trace[1565451678] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"196.312142ms","start":"2026-08-11T07:35:13.429474Z","end":"2026-08-11T07:35:13.625787Z","steps":["trace[1565451678] 'process raft request' (duration: 103.426871ms)","trace[1565451678] 'compare' (duration: 92.429955ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:13.625898Z","caller":"traceutil/trace.go:171","msg":"trace[1695591868] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"139.707953ms","start":"2026-08-11T07:35:13.486158Z","end":"2026-08-11T07:35:13.625865Z","steps":["trace[1695591868] 'process raft request' (duration: 139.586921ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:13.62592Z","caller":"traceutil/trace.go:171","msg":"trace[1593985720] linearizableReadLoop","detail":"{readStateIndex:5106; appliedIndex:5105; }","duration":"147.723948ms","start":"2026-08-11T07:35:13.478167Z","end":"2026-08-11T07:35:13.625891Z","steps":["trace[1593985720] 'read index received' (duration: 54.752036ms)","trace[1593985720] 'applied index is now lower than readState.Index' (duration: 92.970032ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:35:13.626772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.593815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-11T07:35:13.626847Z","caller":"traceutil/trace.go:171","msg":"trace[1727083834] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4921; }","duration":"177.700046ms","start":"2026-08-11T07:35:13.449131Z","end":"2026-08-11T07:35:13.626831Z","steps":["trace[1727083834] 'agreement among raft nodes before linearized reading' (duration: 177.509543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:13.627307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.180522ms","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-11T07:35:13.627381Z","caller":"traceutil/trace.go:171","msg":"trace[427248885] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4921; }","duration":"178.305424ms","start":"2026-08-11T07:35:13.449061Z","end":"2026-08-11T07:35:13.627366Z","steps":["trace[427248885] 'agreement among raft nodes before linearized reading' (duration: 176.915395ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:13.628329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.473573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-08-11T07:35:13.628458Z","caller":"traceutil/trace.go:171","msg":"trace[1828084479] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4921; }","duration":"125.665426ms","start":"2026-08-11T07:35:13.502769Z","end":"2026-08-11T07:35:13.628435Z","steps":["trace[1828084479] 'agreement among raft nodes before linearized reading' (duration: 123.6737ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:13.769785Z","caller":"traceutil/trace.go:171","msg":"trace[289406755] linearizableReadLoop","detail":"{readStateIndex:5109; appliedIndex:5107; }","duration":"115.227537ms","start":"2026-08-11T07:35:13.654526Z","end":"2026-08-11T07:35:13.769753Z","steps":["trace[289406755] 'read index received' (duration: 68.59886ms)","trace[289406755] 'applied index is now lower than readState.Index' (duration: 46.627727ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:13.769897Z","caller":"traceutil/trace.go:171","msg":"trace[1487047344] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"137.197708ms","start":"2026-08-11T07:35:13.632646Z","end":"2026-08-11T07:35:13.769843Z","steps":["trace[1487047344] 'process raft request' (duration: 133.162875ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:13.770111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.267224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-817fa95b-c13a-4a65-ac28-020efd5cf5cd\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-08-11T07:35:13.770164Z","caller":"traceutil/trace.go:171","msg":"trace[71605703] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-817fa95b-c13a-4a65-ac28-020efd5cf5cd; range_end:; response_count:1; response_revision:4923; }","duration":"114.338375ms","start":"2026-08-11T07:35:13.655811Z","end":"2026-08-11T07:35:13.77015Z","steps":["trace[71605703] 'agreement among raft nodes before linearized reading' (duration: 114.132733ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:13.770152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.599122ms","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-11T07:35:13.77025Z","caller":"traceutil/trace.go:171","msg":"trace[366818184] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4923; }","duration":"115.758074ms","start":"2026-08-11T07:35:13.654474Z","end":"2026-08-11T07:35:13.770232Z","steps":["trace[366818184] 'agreement among raft nodes before linearized reading' (duration: 115.44915ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:13.770278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.761785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"info","ts":"2026-08-11T07:35:13.770363Z","caller":"traceutil/trace.go:171","msg":"trace[1700169355] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4923; }","duration":"109.898057ms","start":"2026-08-11T07:35:13.660443Z","end":"2026-08-11T07:35:13.770341Z","steps":["trace[1700169355] 'agreement among raft nodes before linearized reading' (duration: 109.606573ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:16.162821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.47235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-08-11T07:35:16.162868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.427044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-11T07:35:16.162897Z","caller":"traceutil/trace.go:171","msg":"trace[712791087] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4980; }","duration":"377.586272ms","start":"2026-08-11T07:35:15.785294Z","end":"2026-08-11T07:35:16.16288Z","steps":["trace[712791087] 'range keys from in-memory index tree' (duration: 377.348108ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:16.162941Z","caller":"traceutil/trace.go:171","msg":"trace[1611624028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4980; }","duration":"245.536605ms","start":"2026-08-11T07:35:15.917386Z","end":"2026-08-11T07:35:16.162922Z","steps":["trace[1611624028] 'range keys from in-memory index tree' (duration: 245.272102ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:16.162929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.590345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-817fa95b-c13a-4a65-ac28-020efd5cf5cd\" ","response":"range_response_count:1 size:4076"} {"level":"info","ts":"2026-08-11T07:35:16.163037Z","caller":"traceutil/trace.go:171","msg":"trace[1566622941] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-817fa95b-c13a-4a65-ac28-020efd5cf5cd; range_end:; response_count:1; response_revision:4980; }","duration":"257.711947ms","start":"2026-08-11T07:35:15.905273Z","end":"2026-08-11T07:35:16.162985Z","steps":["trace[1566622941] 'range keys from in-memory index tree' (duration: 257.432513ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:16.162938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:15.785281Z","time spent":"377.648503ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T07:35:22.953199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.575331ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:35:22.953318Z","caller":"traceutil/trace.go:171","msg":"trace[1333245231] linearizableReadLoop","detail":"{readStateIndex:5302; appliedIndex:5301; }","duration":"736.594811ms","start":"2026-08-11T07:35:22.216704Z","end":"2026-08-11T07:35:22.953299Z","steps":["trace[1333245231] 'read index received' (duration: 50.818397ms)","trace[1333245231] 'applied index is now lower than readState.Index' (duration: 685.775174ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:22.953359Z","caller":"traceutil/trace.go:171","msg":"trace[1247002381] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"749.994067ms","start":"2026-08-11T07:35:22.203324Z","end":"2026-08-11T07:35:22.953318Z","steps":["trace[1247002381] 'process raft request' (duration: 64.220763ms)","trace[1247002381] 'compare' (duration: 684.68492ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:35:22.953519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.802063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-11T07:35:22.953526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:22.203305Z","time spent":"750.126868ms","remote":"127.0.0.1:52208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:35:22.953562Z","caller":"traceutil/trace.go:171","msg":"trace[362159177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5110; }","duration":"736.884175ms","start":"2026-08-11T07:35:22.216667Z","end":"2026-08-11T07:35:22.953551Z","steps":["trace[362159177] 'agreement among raft nodes before linearized reading' (duration: 736.703983ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:22.953599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:22.21665Z","time spent":"736.940125ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T07:35:23.030662Z","caller":"traceutil/trace.go:171","msg":"trace[596982258] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"724.39585ms","start":"2026-08-11T07:35:22.306234Z","end":"2026-08-11T07:35:23.03063Z","steps":["trace[596982258] 'process raft request' (duration: 724.164838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.030853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:22.306214Z","time spent":"724.527542ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:35:23.137494Z","caller":"traceutil/trace.go:171","msg":"trace[1914639019] transaction","detail":"{read_only:false; response_revision:5112; number_of_response:1; }","duration":"566.301434ms","start":"2026-08-11T07:35:22.571146Z","end":"2026-08-11T07:35:23.137447Z","steps":["trace[1914639019] 'process raft request' (duration: 520.090798ms)","trace[1914639019] 'compare' (duration: 45.80361ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:23.137541Z","caller":"traceutil/trace.go:171","msg":"trace[353266066] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"431.456964ms","start":"2026-08-11T07:35:22.706059Z","end":"2026-08-11T07:35:23.137516Z","steps":["trace[353266066] 'process raft request' (duration: 431.298561ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.137659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:22.571105Z","time spent":"566.466366ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:35:23.137746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:22.706032Z","time spent":"431.608196ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:35:23.137766Z","caller":"traceutil/trace.go:171","msg":"trace[2131556559] linearizableReadLoop","detail":"{readStateIndex:5305; appliedIndex:5302; }","duration":"184.366229ms","start":"2026-08-11T07:35:22.953344Z","end":"2026-08-11T07:35:23.13771Z","steps":["trace[2131556559] 'read index received' (duration: 77.057412ms)","trace[2131556559] 'applied index is now lower than readState.Index' (duration: 107.307627ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:35:23.138001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.425513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T07:35:23.138037Z","caller":"traceutil/trace.go:171","msg":"trace[1263898698] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:5115; }","duration":"850.516195ms","start":"2026-08-11T07:35:22.287509Z","end":"2026-08-11T07:35:23.138025Z","steps":["trace[1263898698] 'agreement among raft nodes before linearized reading' (duration: 850.379444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.138071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:22.287491Z","time spent":"850.570756ms","remote":"127.0.0.1:52322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":69,"response size":31,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:35:23.138036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.824177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99b0867c-4405-4252-92a7-dca03b629b45\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-08-11T07:35:23.138088Z","caller":"traceutil/trace.go:171","msg":"trace[2096422688] transaction","detail":"{read_only:false; response_revision:5114; number_of_response:1; }","duration":"179.847059ms","start":"2026-08-11T07:35:22.958225Z","end":"2026-08-11T07:35:23.138072Z","steps":["trace[2096422688] 'process raft request' (duration: 179.237981ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.138407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.513463ms","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-11T07:35:23.138442Z","caller":"traceutil/trace.go:171","msg":"trace[929270427] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5115; }","duration":"907.563083ms","start":"2026-08-11T07:35:22.23087Z","end":"2026-08-11T07:35:23.138433Z","steps":["trace[929270427] 'agreement among raft nodes before linearized reading' (duration: 907.465142ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.138465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:22.230864Z","time spent":"907.595314ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-11T07:35:23.138142Z","caller":"traceutil/trace.go:171","msg":"trace[1938386219] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-99b0867c-4405-4252-92a7-dca03b629b45; range_end:; response_count:1; response_revision:5115; }","duration":"629.947059ms","start":"2026-08-11T07:35:22.508174Z","end":"2026-08-11T07:35:23.138122Z","steps":["trace[1938386219] 'agreement among raft nodes before linearized reading' (duration: 629.666615ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.138563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:22.508154Z","time spent":"630.365554ms","remote":"127.0.0.1:52294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99b0867c-4405-4252-92a7-dca03b629b45\" "} {"level":"info","ts":"2026-08-11T07:35:23.439941Z","caller":"traceutil/trace.go:171","msg":"trace[131210605] transaction","detail":"{read_only:false; response_revision:5117; number_of_response:1; }","duration":"295.381634ms","start":"2026-08-11T07:35:23.14453Z","end":"2026-08-11T07:35:23.439911Z","steps":["trace[131210605] 'process raft request' (duration: 295.058699ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:23.440336Z","caller":"traceutil/trace.go:171","msg":"trace[1383738268] transaction","detail":"{read_only:false; response_revision:5118; number_of_response:1; }","duration":"290.913056ms","start":"2026-08-11T07:35:23.149398Z","end":"2026-08-11T07:35:23.440311Z","steps":["trace[1383738268] 'process raft request' (duration: 290.43411ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.929017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.287667ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:35:23.929364Z","caller":"traceutil/trace.go:171","msg":"trace[1686054706] transaction","detail":"{read_only:false; response_revision:5124; number_of_response:1; }","duration":"410.766297ms","start":"2026-08-11T07:35:23.518581Z","end":"2026-08-11T07:35:23.929347Z","steps":["trace[1686054706] 'process raft request' (duration: 410.713417ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.929445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:23.518548Z","time spent":"410.861189ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:35:23.929447Z","caller":"traceutil/trace.go:171","msg":"trace[2086429806] transaction","detail":"{read_only:false; response_revision:5122; number_of_response:1; }","duration":"480.37064ms","start":"2026-08-11T07:35:23.449045Z","end":"2026-08-11T07:35:23.929416Z","steps":["trace[2086429806] 'process raft request' (duration: 480.141707ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:23.929447Z","caller":"traceutil/trace.go:171","msg":"trace[612510283] linearizableReadLoop","detail":"{readStateIndex:5315; appliedIndex:5311; }","duration":"440.740641ms","start":"2026-08-11T07:35:23.488667Z","end":"2026-08-11T07:35:23.929408Z","steps":["trace[612510283] 'read index received' (duration: 300.904487ms)","trace[612510283] 'applied index is now lower than readState.Index' (duration: 139.831154ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:23.929623Z","caller":"traceutil/trace.go:171","msg":"trace[1395229119] transaction","detail":"{read_only:false; response_revision:5120; number_of_response:1; }","duration":"480.685944ms","start":"2026-08-11T07:35:23.4489Z","end":"2026-08-11T07:35:23.929585Z","steps":["trace[1395229119] 'process raft request' (duration: 340.659538ms)","trace[1395229119] 'compare' (duration: 139.104965ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:35:23.929768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.089955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-08-11T07:35:23.929837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.577842ms","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-11T07:35:23.929839Z","caller":"traceutil/trace.go:171","msg":"trace[214898058] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5124; }","duration":"441.197437ms","start":"2026-08-11T07:35:23.488621Z","end":"2026-08-11T07:35:23.929819Z","steps":["trace[214898058] 'agreement among raft nodes before linearized reading' (duration: 440.969534ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:23.92988Z","caller":"traceutil/trace.go:171","msg":"trace[1729138035] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5124; }","duration":"117.661614ms","start":"2026-08-11T07:35:23.812202Z","end":"2026-08-11T07:35:23.929863Z","steps":["trace[1729138035] 'agreement among raft nodes before linearized reading' (duration: 117.518432ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.929876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.734985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-08-11T07:35:23.929892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:23.488599Z","time spent":"441.279039ms","remote":"127.0.0.1:38960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3340,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-08-11T07:35:23.92994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.545845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-11T07:35:23.929961Z","caller":"traceutil/trace.go:171","msg":"trace[2002862712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5124; }","duration":"249.868258ms","start":"2026-08-11T07:35:23.680073Z","end":"2026-08-11T07:35:23.929942Z","steps":["trace[2002862712] 'agreement among raft nodes before linearized reading' (duration: 249.624674ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:23.930013Z","caller":"traceutil/trace.go:171","msg":"trace[617741774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5124; }","duration":"147.655387ms","start":"2026-08-11T07:35:23.782338Z","end":"2026-08-11T07:35:23.929993Z","steps":["trace[617741774] 'agreement among raft nodes before linearized reading' (duration: 147.429063ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:23.929574Z","caller":"traceutil/trace.go:171","msg":"trace[1551990414] transaction","detail":"{read_only:false; response_revision:5123; number_of_response:1; }","duration":"479.800262ms","start":"2026-08-11T07:35:23.449765Z","end":"2026-08-11T07:35:23.929565Z","steps":["trace[1551990414] 'process raft request' (duration: 479.474848ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.930272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:23.44974Z","time spent":"480.460182ms","remote":"127.0.0.1:52208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":853,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:35:23.929707Z","caller":"traceutil/trace.go:171","msg":"trace[100827884] transaction","detail":"{read_only:false; response_revision:5121; number_of_response:1; }","duration":"480.697794ms","start":"2026-08-11T07:35:23.448994Z","end":"2026-08-11T07:35:23.929692Z","steps":["trace[100827884] 'process raft request' (duration: 480.124947ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:23.930392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:23.448983Z","time spent":"481.356823ms","remote":"127.0.0.1:52376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1868,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:35:23.929643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:23.449022Z","time spent":"480.507742ms","remote":"127.0.0.1:52376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1454,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:35:23.931277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:23.448888Z","time spent":"480.880806ms","remote":"127.0.0.1:52278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1282,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:35:24.241418Z","caller":"traceutil/trace.go:171","msg":"trace[2138609318] linearizableReadLoop","detail":"{readStateIndex:5319; appliedIndex:5316; }","duration":"304.765414ms","start":"2026-08-11T07:35:23.936623Z","end":"2026-08-11T07:35:24.241388Z","steps":["trace[2138609318] 'read index received' (duration: 87.622349ms)","trace[2138609318] 'applied index is now lower than readState.Index' (duration: 217.141885ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:24.241498Z","caller":"traceutil/trace.go:171","msg":"trace[1616589155] transaction","detail":"{read_only:false; response_revision:5127; number_of_response:1; }","duration":"305.30944ms","start":"2026-08-11T07:35:23.936163Z","end":"2026-08-11T07:35:24.241472Z","steps":["trace[1616589155] 'process raft request' (duration: 305.177879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:24.241644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.703664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6fc767c766-24tt8.18cab00195365378\" ","response":"range_response_count:1 size:896"} {"level":"warn","ts":"2026-08-11T07:35:24.241644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:23.936153Z","time spent":"305.398621ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:35:24.24169Z","caller":"traceutil/trace.go:171","msg":"trace[1704083725] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-6fc767c766-24tt8.18cab00195365378; range_end:; response_count:1; response_revision:5127; }","duration":"179.778835ms","start":"2026-08-11T07:35:24.061899Z","end":"2026-08-11T07:35:24.241678Z","steps":["trace[1704083725] 'agreement among raft nodes before linearized reading' (duration: 179.647903ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:24.241898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.958944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16084"} {"level":"info","ts":"2026-08-11T07:35:24.241926Z","caller":"traceutil/trace.go:171","msg":"trace[371897752] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5127; }","duration":"178.987564ms","start":"2026-08-11T07:35:24.06293Z","end":"2026-08-11T07:35:24.241918Z","steps":["trace[371897752] 'agreement among raft nodes before linearized reading' (duration: 178.893983ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:24.242188Z","caller":"traceutil/trace.go:171","msg":"trace[1954408175] transaction","detail":"{read_only:false; response_revision:5126; number_of_response:1; }","duration":"306.71875ms","start":"2026-08-11T07:35:23.935457Z","end":"2026-08-11T07:35:24.242175Z","steps":["trace[1954408175] 'process raft request' (duration: 305.658606ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:24.24211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.456783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"warn","ts":"2026-08-11T07:35:24.242246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:23.935437Z","time spent":"306.779991ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:35:24.242357Z","caller":"traceutil/trace.go:171","msg":"trace[1157402216] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:5127; }","duration":"305.657686ms","start":"2026-08-11T07:35:23.936615Z","end":"2026-08-11T07:35:24.242272Z","steps":["trace[1157402216] 'agreement among raft nodes before linearized reading' (duration: 305.186079ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:24.242551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:23.936588Z","time spent":"305.866509ms","remote":"127.0.0.1:52230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1345,"request content":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" "} {"level":"warn","ts":"2026-08-11T07:35:24.523418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.848141ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:35:24.523515Z","caller":"traceutil/trace.go:171","msg":"trace[2092307883] linearizableReadLoop","detail":"{readStateIndex:5320; appliedIndex:5319; }","duration":"277.206332ms","start":"2026-08-11T07:35:24.246293Z","end":"2026-08-11T07:35:24.5235Z","steps":["trace[2092307883] 'read index received' (duration: 89.191889ms)","trace[2092307883] 'applied index is now lower than readState.Index' (duration: 188.013093ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:24.52357Z","caller":"traceutil/trace.go:171","msg":"trace[1484871421] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"277.553428ms","start":"2026-08-11T07:35:24.245977Z","end":"2026-08-11T07:35:24.52353Z","steps":["trace[1484871421] 'process raft request' (duration: 89.492843ms)","trace[1484871421] 'compare' (duration: 187.506827ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:35:24.523983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.668789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-817fa95b-c13a-4a65-ac28-020efd5cf5cd\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-08-11T07:35:24.524063Z","caller":"traceutil/trace.go:171","msg":"trace[524966706] range","detail":"{range_begin:/registry/persistentvolumes/pvc-817fa95b-c13a-4a65-ac28-020efd5cf5cd; range_end:; response_count:1; response_revision:5128; }","duration":"278.000183ms","start":"2026-08-11T07:35:24.246043Z","end":"2026-08-11T07:35:24.524044Z","steps":["trace[524966706] 'agreement among raft nodes before linearized reading' (duration: 277.519367ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:24.53102Z","caller":"traceutil/trace.go:171","msg":"trace[582998328] transaction","detail":"{read_only:false; response_revision:5129; number_of_response:1; }","duration":"274.346734ms","start":"2026-08-11T07:35:24.256657Z","end":"2026-08-11T07:35:24.531004Z","steps":["trace[582998328] 'process raft request' (duration: 274.090841ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:24.531113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.322409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-08-11T07:35:24.531209Z","caller":"traceutil/trace.go:171","msg":"trace[266424666] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:5129; }","duration":"282.473311ms","start":"2026-08-11T07:35:24.248721Z","end":"2026-08-11T07:35:24.531195Z","steps":["trace[266424666] 'agreement among raft nodes before linearized reading' (duration: 282.258399ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:26.359288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.073078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-11T07:35:26.359369Z","caller":"traceutil/trace.go:171","msg":"trace[1773294698] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5161; }","duration":"113.205771ms","start":"2026-08-11T07:35:26.246143Z","end":"2026-08-11T07:35:26.359349Z","steps":["trace[1773294698] 'range keys from in-memory index tree' (duration: 112.894147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:26.359385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.760871ms","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-11T07:35:26.359448Z","caller":"traceutil/trace.go:171","msg":"trace[1875098038] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5161; }","duration":"111.903053ms","start":"2026-08-11T07:35:26.247531Z","end":"2026-08-11T07:35:26.359434Z","steps":["trace[1875098038] 'range keys from in-memory index tree' (duration: 111.511928ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:26.359401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.796555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99b0867c-4405-4252-92a7-dca03b629b45\" ","response":"range_response_count:1 size:3938"} {"level":"info","ts":"2026-08-11T07:35:26.359585Z","caller":"traceutil/trace.go:171","msg":"trace[1819798128] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-99b0867c-4405-4252-92a7-dca03b629b45; range_end:; response_count:1; response_revision:5161; }","duration":"102.985177ms","start":"2026-08-11T07:35:26.256575Z","end":"2026-08-11T07:35:26.35956Z","steps":["trace[1819798128] 'range keys from in-memory index tree' (duration: 102.500731ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:27.691427Z","caller":"traceutil/trace.go:171","msg":"trace[645458415] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"322.470842ms","start":"2026-08-11T07:35:27.368927Z","end":"2026-08-11T07:35:27.691398Z","steps":["trace[645458415] 'process raft request' (duration: 321.951865ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:27.691654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:27.368907Z","time spent":"322.668055ms","remote":"127.0.0.1:52294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3950,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:35:27.691734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.433902ms","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-11T07:35:27.691756Z","caller":"traceutil/trace.go:171","msg":"trace[758409732] linearizableReadLoop","detail":"{readStateIndex:5370; appliedIndex:5369; }","duration":"234.011616ms","start":"2026-08-11T07:35:27.457275Z","end":"2026-08-11T07:35:27.691287Z","steps":["trace[758409732] 'read index received' (duration: 233.544231ms)","trace[758409732] 'applied index is now lower than readState.Index' (duration: 466.285µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:27.691848Z","caller":"traceutil/trace.go:171","msg":"trace[925634321] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5177; }","duration":"234.566734ms","start":"2026-08-11T07:35:27.457261Z","end":"2026-08-11T07:35:27.691828Z","steps":["trace[925634321] 'agreement among raft nodes before linearized reading' (duration: 234.26257ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:32.528731Z","caller":"traceutil/trace.go:171","msg":"trace[1518972502] linearizableReadLoop","detail":"{readStateIndex:5451; appliedIndex:5450; }","duration":"127.551438ms","start":"2026-08-11T07:35:32.401151Z","end":"2026-08-11T07:35:32.528703Z","steps":["trace[1518972502] 'read index received' (duration: 127.319155ms)","trace[1518972502] 'applied index is now lower than readState.Index' (duration: 212.742µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:32.528855Z","caller":"traceutil/trace.go:171","msg":"trace[428152493] transaction","detail":"{read_only:false; response_revision:5254; number_of_response:1; }","duration":"135.36064ms","start":"2026-08-11T07:35:32.393453Z","end":"2026-08-11T07:35:32.528813Z","steps":["trace[428152493] 'process raft request' (duration: 135.059366ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:32.52898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.814211ms","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-11T07:35:32.529022Z","caller":"traceutil/trace.go:171","msg":"trace[2135021169] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5254; }","duration":"127.875011ms","start":"2026-08-11T07:35:32.40113Z","end":"2026-08-11T07:35:32.529004Z","steps":["trace[2135021169] 'agreement among raft nodes before linearized reading' (duration: 127.693759ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:33.664284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.590794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:35:33.664402Z","caller":"traceutil/trace.go:171","msg":"trace[2062453004] transaction","detail":"{read_only:false; response_revision:5261; number_of_response:1; }","duration":"402.607698ms","start":"2026-08-11T07:35:33.261775Z","end":"2026-08-11T07:35:33.664383Z","steps":["trace[2062453004] 'process raft request' (duration: 111.826801ms)","trace[2062453004] 'compare' (duration: 290.447432ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:35:33.664464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:33.261754Z","time spent":"402.679608ms","remote":"127.0.0.1:52294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13644,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:35:40.435859Z","caller":"traceutil/trace.go:171","msg":"trace[429280188] linearizableReadLoop","detail":"{readStateIndex:5518; appliedIndex:5517; }","duration":"336.313128ms","start":"2026-08-11T07:35:40.099521Z","end":"2026-08-11T07:35:40.435835Z","steps":["trace[429280188] 'read index received' (duration: 336.120396ms)","trace[429280188] 'applied index is now lower than readState.Index' (duration: 191.882µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:40.435965Z","caller":"traceutil/trace.go:171","msg":"trace[952752022] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"445.391957ms","start":"2026-08-11T07:35:39.990534Z","end":"2026-08-11T07:35:40.435926Z","steps":["trace[952752022] 'process raft request' (duration: 445.115033ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:40.436099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:39.990512Z","time spent":"445.514549ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:35:40.436229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.712385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:35:40.436311Z","caller":"traceutil/trace.go:171","msg":"trace[1479814495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5320; }","duration":"336.835146ms","start":"2026-08-11T07:35:40.099462Z","end":"2026-08-11T07:35:40.436297Z","steps":["trace[1479814495] 'agreement among raft nodes before linearized reading' (duration: 336.603183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:40.436374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:40.09944Z","time spent":"336.922257ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T07:35:40.942247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.634618ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-08-11T07:35:40.942609Z","caller":"traceutil/trace.go:171","msg":"trace[678596813] linearizableReadLoop","detail":"{readStateIndex:5519; appliedIndex:5518; }","duration":"506.572426ms","start":"2026-08-11T07:35:40.436004Z","end":"2026-08-11T07:35:40.942576Z","steps":["trace[678596813] 'read index received' (duration: 26.621904ms)","trace[678596813] 'applied index is now lower than readState.Index' (duration: 479.946582ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:40.942988Z","caller":"traceutil/trace.go:171","msg":"trace[2064443180] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"500.424037ms","start":"2026-08-11T07:35:40.442539Z","end":"2026-08-11T07:35:40.942963Z","steps":["trace[2064443180] 'process raft request' (duration: 499.815609ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:40.943107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:40.442515Z","time spent":"500.519098ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:35:40.943239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.825214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:35:40.943356Z","caller":"traceutil/trace.go:171","msg":"trace[2036950258] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5322; }","duration":"783.935524ms","start":"2026-08-11T07:35:40.159349Z","end":"2026-08-11T07:35:40.943284Z","steps":["trace[2036950258] 'agreement among raft nodes before linearized reading' (duration: 783.814233ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:40.943404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:40.159316Z","time spent":"784.077507ms","remote":"127.0.0.1:52132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T07:35:40.943349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.089833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17147"} {"level":"warn","ts":"2026-08-11T07:35:40.943499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.438629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-11T07:35:40.943585Z","caller":"traceutil/trace.go:171","msg":"trace[105157430] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5322; }","duration":"700.328645ms","start":"2026-08-11T07:35:40.243202Z","end":"2026-08-11T07:35:40.94353Z","steps":["trace[105157430] 'agreement among raft nodes before linearized reading' (duration: 699.90488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:40.943666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:40.243184Z","time spent":"700.467897ms","remote":"127.0.0.1:52294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":17171,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-08-11T07:35:40.943646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.774663ms","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-11T07:35:40.943821Z","caller":"traceutil/trace.go:171","msg":"trace[444981508] 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:5322; }","duration":"652.995505ms","start":"2026-08-11T07:35:40.290805Z","end":"2026-08-11T07:35:40.943801Z","steps":["trace[444981508] 'agreement among raft nodes before linearized reading' (duration: 652.334427ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:40.943692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.814916ms","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-11T07:35:40.944093Z","caller":"traceutil/trace.go:171","msg":"trace[272448757] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5322; }","duration":"372.234542ms","start":"2026-08-11T07:35:40.571845Z","end":"2026-08-11T07:35:40.944079Z","steps":["trace[272448757] 'agreement among raft nodes before linearized reading' (duration: 371.777047ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:40.943584Z","caller":"traceutil/trace.go:171","msg":"trace[277767418] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5322; }","duration":"380.569091ms","start":"2026-08-11T07:35:40.562992Z","end":"2026-08-11T07:35:40.943561Z","steps":["trace[277767418] 'agreement among raft nodes before linearized reading' (duration: 380.310638ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:40.944148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:40.571834Z","time spent":"372.299683ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-11T07:35:40.944208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:40.56297Z","time spent":"381.188308ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T07:35:40.943952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:40.290786Z","time spent":"653.125866ms","remote":"127.0.0.1:52274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2106,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-08-11T07:35:41.091476Z","caller":"traceutil/trace.go:171","msg":"trace[768903859] transaction","detail":"{read_only:false; response_revision:5323; number_of_response:1; }","duration":"140.851427ms","start":"2026-08-11T07:35:40.950592Z","end":"2026-08-11T07:35:41.091444Z","steps":["trace[768903859] 'process raft request' (duration: 98.337998ms)","trace[768903859] 'compare' (duration: 42.368437ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:41.242541Z","caller":"traceutil/trace.go:171","msg":"trace[819535868] transaction","detail":"{read_only:false; response_revision:5324; number_of_response:1; }","duration":"291.477478ms","start":"2026-08-11T07:35:40.951035Z","end":"2026-08-11T07:35:41.242512Z","steps":["trace[819535868] 'process raft request' (duration: 250.52799ms)","trace[819535868] 'compare' (duration: 40.717355ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:41.242757Z","caller":"traceutil/trace.go:171","msg":"trace[1384960353] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"285.596742ms","start":"2026-08-11T07:35:40.957149Z","end":"2026-08-11T07:35:41.242746Z","steps":["trace[1384960353] 'process raft request' (duration: 285.280999ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:41.242912Z","caller":"traceutil/trace.go:171","msg":"trace[685783423] linearizableReadLoop","detail":"{readStateIndex:5524; appliedIndex:5521; }","duration":"196.720016ms","start":"2026-08-11T07:35:41.046173Z","end":"2026-08-11T07:35:41.242893Z","steps":["trace[685783423] 'read index received' (duration: 2.833236ms)","trace[685783423] 'applied index is now lower than readState.Index' (duration: 193.88465ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:35:41.242931Z","caller":"traceutil/trace.go:171","msg":"trace[1902170332] transaction","detail":"{read_only:false; response_revision:5326; number_of_response:1; }","duration":"150.601851ms","start":"2026-08-11T07:35:41.0923Z","end":"2026-08-11T07:35:41.242902Z","steps":["trace[1902170332] 'process raft request' (duration: 150.419529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:41.243133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.940359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-08-11T07:35:41.243178Z","caller":"traceutil/trace.go:171","msg":"trace[1271425172] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5326; }","duration":"197.0578ms","start":"2026-08-11T07:35:41.046108Z","end":"2026-08-11T07:35:41.243166Z","steps":["trace[1271425172] 'agreement among raft nodes before linearized reading' (duration: 196.890958ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:41.254751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.315307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-11T07:35:41.254829Z","caller":"traceutil/trace.go:171","msg":"trace[1110403798] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5327; }","duration":"105.4501ms","start":"2026-08-11T07:35:41.149363Z","end":"2026-08-11T07:35:41.254813Z","steps":["trace[1110403798] 'agreement among raft nodes before linearized reading' (duration: 104.885003ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:41.466116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.898215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-08-11T07:35:41.466209Z","caller":"traceutil/trace.go:171","msg":"trace[1652566468] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5329; }","duration":"123.066706ms","start":"2026-08-11T07:35:41.343121Z","end":"2026-08-11T07:35:41.466187Z","steps":["trace[1652566468] 'range keys from in-memory index tree' (duration: 122.60923ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:41.628325Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2873} {"level":"info","ts":"2026-08-11T07:35:41.628927Z","caller":"traceutil/trace.go:171","msg":"trace[355502560] compact","detail":"{revision:2873; response_revision:5330; }","duration":"129.691952ms","start":"2026-08-11T07:35:41.499173Z","end":"2026-08-11T07:35:41.628865Z","steps":["trace[355502560] 'process raft request' (duration: 39.58245ms)","trace[355502560] 'check and update compact revision' (duration: 89.302301ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:35:41.982574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.050261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:35:41.982641Z","caller":"traceutil/trace.go:171","msg":"trace[517201342] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:5330; }","duration":"315.173763ms","start":"2026-08-11T07:35:41.667454Z","end":"2026-08-11T07:35:41.982628Z","steps":["trace[517201342] 'count revisions from in-memory index tree' (duration: 314.99097ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:35:41.982658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.617452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-08-11T07:35:41.982674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:35:41.667436Z","time spent":"315.228613ms","remote":"127.0.0.1:38934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"info","ts":"2026-08-11T07:35:41.982704Z","caller":"traceutil/trace.go:171","msg":"trace[1434964269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5330; }","duration":"202.713283ms","start":"2026-08-11T07:35:41.779979Z","end":"2026-08-11T07:35:41.982692Z","steps":["trace[1434964269] 'range keys from in-memory index tree' (duration: 202.408748ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:35:42.140343Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2873,"took":"509.616988ms","hash":2262613425,"current-db-size-bytes":52047872,"current-db-size":"52 MB","current-db-size-in-use-bytes":27545600,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-11T07:35:42.140423Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2262613425,"revision":2873,"compact-revision":-1} {"level":"info","ts":"2026-08-11T07:36:06.297784Z","caller":"traceutil/trace.go:171","msg":"trace[614071768] linearizableReadLoop","detail":"{readStateIndex:5690; appliedIndex:5689; }","duration":"136.13767ms","start":"2026-08-11T07:36:06.161615Z","end":"2026-08-11T07:36:06.297752Z","steps":["trace[614071768] 'read index received' (duration: 117.346202ms)","trace[614071768] 'applied index is now lower than readState.Index' (duration: 18.790078ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:36:06.297891Z","caller":"traceutil/trace.go:171","msg":"trace[631597776] transaction","detail":"{read_only:false; response_revision:5485; number_of_response:1; }","duration":"166.360791ms","start":"2026-08-11T07:36:06.131481Z","end":"2026-08-11T07:36:06.297841Z","steps":["trace[631597776] 'process raft request' (duration: 147.496972ms)","trace[631597776] 'compare' (duration: 18.639985ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:36:06.297997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.370162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:36:06.298079Z","caller":"traceutil/trace.go:171","msg":"trace[2100179080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5485; }","duration":"136.508454ms","start":"2026-08-11T07:36:06.16155Z","end":"2026-08-11T07:36:06.298058Z","steps":["trace[2100179080] 'agreement among raft nodes before linearized reading' (duration: 136.332742ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:36:57.8139Z","caller":"traceutil/trace.go:171","msg":"trace[1933842336] transaction","detail":"{read_only:false; response_revision:5933; number_of_response:1; }","duration":"154.037263ms","start":"2026-08-11T07:36:57.659844Z","end":"2026-08-11T07:36:57.813881Z","steps":["trace[1933842336] 'process raft request' (duration: 144.329564ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:00.050519Z","caller":"traceutil/trace.go:171","msg":"trace[366459067] linearizableReadLoop","detail":"{readStateIndex:6162; appliedIndex:6161; }","duration":"228.732562ms","start":"2026-08-11T07:36:59.821749Z","end":"2026-08-11T07:37:00.050482Z","steps":["trace[366459067] 'read index received' (duration: 228.55095ms)","trace[366459067] 'applied index is now lower than readState.Index' (duration: 180.652µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:37:00.050561Z","caller":"traceutil/trace.go:171","msg":"trace[1504123877] transaction","detail":"{read_only:false; response_revision:5944; number_of_response:1; }","duration":"230.476095ms","start":"2026-08-11T07:36:59.82006Z","end":"2026-08-11T07:37:00.050536Z","steps":["trace[1504123877] 'process raft request' (duration: 230.177431ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:37:00.050875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.086666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8241"} {"level":"info","ts":"2026-08-11T07:37:00.051019Z","caller":"traceutil/trace.go:171","msg":"trace[28434942] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:5944; }","duration":"229.306769ms","start":"2026-08-11T07:36:59.821687Z","end":"2026-08-11T07:37:00.050993Z","steps":["trace[28434942] 'agreement among raft nodes before linearized reading' (duration: 228.915485ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:37:00.206487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.811724ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-08-11T07:37:00.20661Z","caller":"traceutil/trace.go:171","msg":"trace[1519247316] linearizableReadLoop","detail":"{readStateIndex:6163; appliedIndex:6162; }","duration":"155.992123ms","start":"2026-08-11T07:37:00.050594Z","end":"2026-08-11T07:37:00.206586Z","steps":["trace[1519247316] 'read index received' (duration: 30.041527ms)","trace[1519247316] 'applied index is now lower than readState.Index' (duration: 125.948746ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:37:00.206777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.306298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:37:00.206817Z","caller":"traceutil/trace.go:171","msg":"trace[1332599481] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:5944; }","duration":"215.410959ms","start":"2026-08-11T07:36:59.991395Z","end":"2026-08-11T07:37:00.206806Z","steps":["trace[1332599481] 'agreement among raft nodes before linearized reading' (duration: 215.315208ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:37:00.207082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.775683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-11T07:37:00.207053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.465549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:37:00.207124Z","caller":"traceutil/trace.go:171","msg":"trace[1660725041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5944; }","duration":"355.874454ms","start":"2026-08-11T07:36:59.851237Z","end":"2026-08-11T07:37:00.207111Z","steps":["trace[1660725041] 'agreement among raft nodes before linearized reading' (duration: 355.649861ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:00.207137Z","caller":"traceutil/trace.go:171","msg":"trace[1310373988] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:5944; }","duration":"119.633291ms","start":"2026-08-11T07:37:00.087488Z","end":"2026-08-11T07:37:00.207121Z","steps":["trace[1310373988] 'agreement among raft nodes before linearized reading' (duration: 119.451739ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:37:00.207149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:59.851212Z","time spent":"355.932255ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T07:37:00.207393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.285402ms","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-11T07:37:00.207738Z","caller":"traceutil/trace.go:171","msg":"trace[969695846] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5944; }","duration":"357.654845ms","start":"2026-08-11T07:36:59.850018Z","end":"2026-08-11T07:37:00.207673Z","steps":["trace[969695846] 'agreement among raft nodes before linearized reading' (duration: 356.859816ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:37:00.20788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:59.849989Z","time spent":"357.866798ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-11T07:37:37.76257Z","caller":"traceutil/trace.go:171","msg":"trace[1602864251] transaction","detail":"{read_only:false; response_revision:6183; number_of_response:1; }","duration":"106.294176ms","start":"2026-08-11T07:37:37.656214Z","end":"2026-08-11T07:37:37.762508Z","steps":["trace[1602864251] 'process raft request' (duration: 106.137325ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:37.890144Z","caller":"traceutil/trace.go:171","msg":"trace[1260127543] transaction","detail":"{read_only:false; response_revision:6184; number_of_response:1; }","duration":"148.813946ms","start":"2026-08-11T07:37:37.741307Z","end":"2026-08-11T07:37:37.890121Z","steps":["trace[1260127543] 'process raft request' (duration: 147.795214ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:37.890458Z","caller":"traceutil/trace.go:171","msg":"trace[1707922194] transaction","detail":"{read_only:false; response_revision:6185; number_of_response:1; }","duration":"129.074739ms","start":"2026-08-11T07:37:37.761287Z","end":"2026-08-11T07:37:37.890362Z","steps":["trace[1707922194] 'process raft request' (duration: 128.520013ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:43.033039Z","caller":"traceutil/trace.go:171","msg":"trace[2025188539] transaction","detail":"{read_only:false; response_revision:6211; number_of_response:1; }","duration":"117.079823ms","start":"2026-08-11T07:37:42.915936Z","end":"2026-08-11T07:37:43.033016Z","steps":["trace[2025188539] 'process raft request' (duration: 116.902521ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:43.139487Z","caller":"traceutil/trace.go:171","msg":"trace[2025396385] transaction","detail":"{read_only:false; response_revision:6212; number_of_response:1; }","duration":"187.992741ms","start":"2026-08-11T07:37:42.951452Z","end":"2026-08-11T07:37:43.139445Z","steps":["trace[2025396385] 'process raft request' (duration: 186.870577ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:43.139942Z","caller":"traceutil/trace.go:171","msg":"trace[1624707636] transaction","detail":"{read_only:false; response_revision:6213; number_of_response:1; }","duration":"105.742996ms","start":"2026-08-11T07:37:43.034179Z","end":"2026-08-11T07:37:43.139922Z","steps":["trace[1624707636] 'process raft request' (duration: 105.375612ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:04.528695Z","caller":"traceutil/trace.go:171","msg":"trace[2017060429] transaction","detail":"{read_only:false; response_revision:6319; number_of_response:1; }","duration":"102.520504ms","start":"2026-08-11T07:38:04.426144Z","end":"2026-08-11T07:38:04.528664Z","steps":["trace[2017060429] 'process raft request' (duration: 102.369229ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:04.821833Z","caller":"traceutil/trace.go:171","msg":"trace[1413516048] transaction","detail":"{read_only:false; response_revision:6321; number_of_response:1; }","duration":"101.755259ms","start":"2026-08-11T07:38:04.720045Z","end":"2026-08-11T07:38:04.8218Z","steps":["trace[1413516048] 'process raft request' (duration: 40.86644ms)","trace[1413516048] 'compare' (duration: 60.425485ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:38:46.737768Z","caller":"traceutil/trace.go:171","msg":"trace[314784945] transaction","detail":"{read_only:false; response_revision:6572; number_of_response:1; }","duration":"113.869883ms","start":"2026-08-11T07:38:46.623872Z","end":"2026-08-11T07:38:46.737742Z","steps":["trace[314784945] 'process raft request' (duration: 113.508543ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:14.96555Z","caller":"traceutil/trace.go:171","msg":"trace[905259406] transaction","detail":"{read_only:false; response_revision:6851; number_of_response:1; }","duration":"113.544935ms","start":"2026-08-11T07:39:14.851979Z","end":"2026-08-11T07:39:14.965523Z","steps":["trace[905259406] 'process raft request' (duration: 113.370321ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:14.965708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.579987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:39:14.965764Z","caller":"traceutil/trace.go:171","msg":"trace[187546324] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:0; response_revision:6851; }","duration":"105.695301ms","start":"2026-08-11T07:39:14.860055Z","end":"2026-08-11T07:39:14.96575Z","steps":["trace[187546324] 'agreement among raft nodes before linearized reading' (duration: 105.576697ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:14.965562Z","caller":"traceutil/trace.go:171","msg":"trace[1008016036] linearizableReadLoop","detail":"{readStateIndex:7103; appliedIndex:7103; }","duration":"105.417133ms","start":"2026-08-11T07:39:14.8601Z","end":"2026-08-11T07:39:14.965518Z","steps":["trace[1008016036] 'read index received' (duration: 105.404603ms)","trace[1008016036] 'applied index is now lower than readState.Index' (duration: 9.79µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:39:15.135917Z","caller":"traceutil/trace.go:171","msg":"trace[568235554] linearizableReadLoop","detail":"{readStateIndex:7104; appliedIndex:7103; }","duration":"154.422252ms","start":"2026-08-11T07:39:14.981457Z","end":"2026-08-11T07:39:15.135879Z","steps":["trace[568235554] 'read index received' (duration: 139.957359ms)","trace[568235554] 'applied index is now lower than readState.Index' (duration: 14.463103ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:39:15.136Z","caller":"traceutil/trace.go:171","msg":"trace[1142082753] transaction","detail":"{read_only:false; response_revision:6852; number_of_response:1; }","duration":"266.64647ms","start":"2026-08-11T07:39:14.86932Z","end":"2026-08-11T07:39:15.135967Z","steps":["trace[1142082753] 'process raft request' (duration: 252.207598ms)","trace[1142082753] 'compare' (duration: 14.016371ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:39:15.136064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.588906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:39:15.136163Z","caller":"traceutil/trace.go:171","msg":"trace[385546840] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:0; response_revision:6852; }","duration":"154.72046ms","start":"2026-08-11T07:39:14.981415Z","end":"2026-08-11T07:39:15.136135Z","steps":["trace[385546840] 'agreement among raft nodes before linearized reading' (duration: 154.565406ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:15.82888Z","caller":"traceutil/trace.go:171","msg":"trace[1164048321] transaction","detail":"{read_only:false; response_revision:6856; number_of_response:1; }","duration":"200.172195ms","start":"2026-08-11T07:39:15.628656Z","end":"2026-08-11T07:39:15.828828Z","steps":["trace[1164048321] 'process raft request' (duration: 198.90493ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:15.828868Z","caller":"traceutil/trace.go:171","msg":"trace[1893035530] linearizableReadLoop","detail":"{readStateIndex:7108; appliedIndex:7107; }","duration":"135.484606ms","start":"2026-08-11T07:39:15.693258Z","end":"2026-08-11T07:39:15.828743Z","steps":["trace[1893035530] 'read index received' (duration: 134.214761ms)","trace[1893035530] 'applied index is now lower than readState.Index' (duration: 1.267305ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:39:15.829582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.289857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-11T07:39:15.829794Z","caller":"traceutil/trace.go:171","msg":"trace[280305906] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6856; }","duration":"136.534165ms","start":"2026-08-11T07:39:15.693204Z","end":"2026-08-11T07:39:15.829738Z","steps":["trace[280305906] 'agreement among raft nodes before linearized reading' (duration: 135.691232ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:32.659007Z","caller":"traceutil/trace.go:171","msg":"trace[1912529925] transaction","detail":"{read_only:false; response_revision:6967; number_of_response:1; }","duration":"142.80352ms","start":"2026-08-11T07:39:32.516172Z","end":"2026-08-11T07:39:32.658975Z","steps":["trace[1912529925] 'process raft request' (duration: 142.495872ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:38.947206Z","caller":"traceutil/trace.go:171","msg":"trace[1955580485] transaction","detail":"{read_only:false; response_revision:6998; number_of_response:1; }","duration":"257.129235ms","start":"2026-08-11T07:39:38.690041Z","end":"2026-08-11T07:39:38.947171Z","steps":["trace[1955580485] 'process raft request' (duration: 256.754776ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:59.244551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.123691ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:39:59.244695Z","caller":"traceutil/trace.go:171","msg":"trace[803529138] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:7158; }","duration":"177.297375ms","start":"2026-08-11T07:39:59.06738Z","end":"2026-08-11T07:39:59.244677Z","steps":["trace[803529138] 'range keys from in-memory index tree' (duration: 177.10383ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:59.244896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.965996ms","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-11T07:39:59.245203Z","caller":"traceutil/trace.go:171","msg":"trace[607997157] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7158; }","duration":"112.076939ms","start":"2026-08-11T07:39:59.13287Z","end":"2026-08-11T07:39:59.244947Z","steps":["trace[607997157] 'range keys from in-memory index tree' (duration: 111.814543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:40:25.503147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.396921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:40:25.503389Z","caller":"traceutil/trace.go:171","msg":"trace[1573904870] linearizableReadLoop","detail":"{readStateIndex:7563; appliedIndex:7562; }","duration":"263.437594ms","start":"2026-08-11T07:40:25.239934Z","end":"2026-08-11T07:40:25.503372Z","steps":["trace[1573904870] 'read index received' (duration: 153.756016ms)","trace[1573904870] 'applied index is now lower than readState.Index' (duration: 109.680138ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:40:25.503477Z","caller":"traceutil/trace.go:171","msg":"trace[1313786816] transaction","detail":"{read_only:false; response_revision:7293; number_of_response:1; }","duration":"263.803502ms","start":"2026-08-11T07:40:25.239623Z","end":"2026-08-11T07:40:25.503426Z","steps":["trace[1313786816] 'process raft request' (duration: 154.017862ms)","trace[1313786816] 'compare' (duration: 109.223707ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:40:25.503534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.589798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:40:25.503582Z","caller":"traceutil/trace.go:171","msg":"trace[1420713408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7293; }","duration":"263.655889ms","start":"2026-08-11T07:40:25.23991Z","end":"2026-08-11T07:40:25.503566Z","steps":["trace[1420713408] 'agreement among raft nodes before linearized reading' (duration: 263.572798ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:40:25.505109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.984245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:40:25.505172Z","caller":"traceutil/trace.go:171","msg":"trace[1336011275] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:7293; }","duration":"155.105998ms","start":"2026-08-11T07:40:25.35005Z","end":"2026-08-11T07:40:25.505156Z","steps":["trace[1336011275] 'agreement among raft nodes before linearized reading' (duration: 154.957054ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:40:41.635501Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5330} {"level":"info","ts":"2026-08-11T07:40:41.727845Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5330,"took":"90.39645ms","hash":702677900,"current-db-size-bytes":52047872,"current-db-size":"52 MB","current-db-size-in-use-bytes":19013632,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-11T07:40:41.727923Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":702677900,"revision":5330,"compact-revision":2873} {"level":"warn","ts":"2026-08-11T07:40:44.111106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.785379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:40:44.111213Z","caller":"traceutil/trace.go:171","msg":"trace[1187001757] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:7411; }","duration":"121.955963ms","start":"2026-08-11T07:40:43.989233Z","end":"2026-08-11T07:40:44.111189Z","steps":["trace[1187001757] 'count revisions from in-memory index tree' (duration: 121.693487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:41:14.039167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.862833ms","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-11T07:41:14.039263Z","caller":"traceutil/trace.go:171","msg":"trace[1093818740] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7560; }","duration":"103.001456ms","start":"2026-08-11T07:41:13.936242Z","end":"2026-08-11T07:41:14.039243Z","steps":["trace[1093818740] 'range keys from in-memory index tree' (duration: 102.688429ms)"],"step_count":1}