{"level":"warn","ts":"2026-09-19T01:49:40.315938Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T01:49:40.316154Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.118: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://162.253.55.118:2380","--initial-cluster=instance=https://162.253.55.118:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.118:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.118: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-09-19T01:49:40.316253Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T01:49:40.316286Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.118:2380"]} {"level":"info","ts":"2026-09-19T01:49:40.31632Z","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-09-19T01:49:40.316987Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"]} {"level":"info","ts":"2026-09-19T01:49:40.317438Z","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://162.253.55.118:2380"],"listen-peer-urls":["https://162.253.55.118:2380"],"advertise-client-urls":["https://162.253.55.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.118: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-09-19T01:49:40.325719Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.99925ms"} {"level":"info","ts":"2026-09-19T01:49:40.332693Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39c975536cfc1086","cluster-id":"ac0a95643fc422f0"} {"level":"info","ts":"2026-09-19T01:49:40.332755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T01:49:40.332777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became follower at term 0"} {"level":"info","ts":"2026-09-19T01:49:40.332788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39c975536cfc1086 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T01:49:40.332796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became follower at term 1"} {"level":"info","ts":"2026-09-19T01:49:40.332835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=(4163988331651928198)"} {"level":"warn","ts":"2026-09-19T01:49:40.339073Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T01:49:40.340587Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T01:49:40.34204Z","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-09-19T01:49:40.344558Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39c975536cfc1086","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T01:49:40.344822Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39c975536cfc1086","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T01:49:40.344852Z","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-09-19T01:49:40.344946Z","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-09-19T01:49:40.344957Z","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-09-19T01:49:40.34565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=(4163988331651928198)"} {"level":"info","ts":"2026-09-19T01:49:40.345746Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ac0a95643fc422f0","local-member-id":"39c975536cfc1086","added-peer-id":"39c975536cfc1086","added-peer-peer-urls":["https://162.253.55.118:2380"]} {"level":"info","ts":"2026-09-19T01:49:40.355492Z","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-09-19T01:49:40.35565Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.118:2380"} {"level":"info","ts":"2026-09-19T01:49:40.355823Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.118:2380"} {"level":"info","ts":"2026-09-19T01:49:40.355914Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39c975536cfc1086","initial-advertise-peer-urls":["https://162.253.55.118:2380"],"listen-peer-urls":["https://162.253.55.118:2380"],"advertise-client-urls":["https://162.253.55.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T01:49:40.355958Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T01:49:40.833485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T01:49:40.833536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T01:49:40.83357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 received MsgPreVoteResp from 39c975536cfc1086 at term 1"} {"level":"info","ts":"2026-09-19T01:49:40.833585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became candidate at term 2"} {"level":"info","ts":"2026-09-19T01:49:40.833592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 received MsgVoteResp from 39c975536cfc1086 at term 2"} {"level":"info","ts":"2026-09-19T01:49:40.833603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became leader at term 2"} {"level":"info","ts":"2026-09-19T01:49:40.833613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39c975536cfc1086 elected leader 39c975536cfc1086 at term 2"} {"level":"info","ts":"2026-09-19T01:49:40.834663Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39c975536cfc1086","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.118:2379]}","request-path":"/0/members/39c975536cfc1086/attributes","cluster-id":"ac0a95643fc422f0","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T01:49:40.834669Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:49:40.834721Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:49:40.835001Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:49:40.835048Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T01:49:40.835157Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T01:49:40.836831Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T01:49:40.837436Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.118:2379"} {"level":"info","ts":"2026-09-19T01:49:40.843316Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ac0a95643fc422f0","local-member-id":"39c975536cfc1086","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:49:40.843468Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:49:40.843889Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:49:42.597588Z","caller":"traceutil/trace.go:171","msg":"trace[1310697686] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"205.13324ms","start":"2026-09-19T01:49:42.392429Z","end":"2026-09-19T01:49:42.597562Z","steps":["trace[1310697686] 'process raft request' (duration: 204.888118ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:42.597602Z","caller":"traceutil/trace.go:171","msg":"trace[1187430389] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:5; }","duration":"203.991856ms","start":"2026-09-19T01:49:42.393576Z","end":"2026-09-19T01:49:42.597568Z","steps":["trace[1187430389] 'read index received' (duration: 203.981956ms)","trace[1187430389] 'applied index is now lower than readState.Index' (duration: 8.18µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:49:42.597983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.344942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:49:42.598085Z","caller":"traceutil/trace.go:171","msg":"trace[877767421] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:2; }","duration":"204.509041ms","start":"2026-09-19T01:49:42.393551Z","end":"2026-09-19T01:49:42.59806Z","steps":["trace[877767421] 'agreement among raft nodes before linearized reading' (duration: 204.111292ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.098395Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1190815860849929343,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-19T01:49:43.397624Z","caller":"traceutil/trace.go:171","msg":"trace[1255182170] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"936.773235ms","start":"2026-09-19T01:49:42.460797Z","end":"2026-09-19T01:49:43.397571Z","steps":["trace[1255182170] 'process raft request' (duration: 936.440289ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.397707Z","caller":"traceutil/trace.go:171","msg":"trace[2057727512] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"936.230969ms","start":"2026-09-19T01:49:42.461398Z","end":"2026-09-19T01:49:43.397629Z","steps":["trace[2057727512] 'process raft request' (duration: 936.072471ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.397791Z","caller":"traceutil/trace.go:171","msg":"trace[1404212083] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"935.659683ms","start":"2026-09-19T01:49:42.462091Z","end":"2026-09-19T01:49:43.39775Z","steps":["trace[1404212083] 'process raft request' (duration: 935.513236ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.397862Z","caller":"traceutil/trace.go:171","msg":"trace[1808626584] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"935.645072ms","start":"2026-09-19T01:49:42.462134Z","end":"2026-09-19T01:49:43.397779Z","steps":["trace[1808626584] 'process raft request' (duration: 935.516436ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.397939Z","caller":"traceutil/trace.go:171","msg":"trace[314476342] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"936.503902ms","start":"2026-09-19T01:49:42.461417Z","end":"2026-09-19T01:49:43.397921Z","steps":["trace[314476342] 'process raft request' (duration: 936.086511ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.398013Z","caller":"traceutil/trace.go:171","msg":"trace[1723809167] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"936.523592ms","start":"2026-09-19T01:49:42.461479Z","end":"2026-09-19T01:49:43.398002Z","steps":["trace[1723809167] 'process raft request' (duration: 936.06638ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.39817Z","caller":"traceutil/trace.go:171","msg":"trace[739370437] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"923.641974ms","start":"2026-09-19T01:49:42.474518Z","end":"2026-09-19T01:49:43.39816Z","steps":["trace[739370437] 'process raft request' (duration: 923.160031ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.398309Z","caller":"traceutil/trace.go:171","msg":"trace[1657701358] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"800.475793ms","start":"2026-09-19T01:49:42.597819Z","end":"2026-09-19T01:49:43.398295Z","steps":["trace[1657701358] 'read index received' (duration: 799.337589ms)","trace[1657701358] 'applied index is now lower than readState.Index' (duration: 1.137164ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:49:43.398456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.885737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-19T01:49:43.398475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.401195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.118\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:49:43.398512Z","caller":"traceutil/trace.go:171","msg":"trace[324488137] range","detail":"{range_begin:/registry/masterleases/162.253.55.118; range_end:; response_count:0; response_revision:10; }","duration":"940.47414ms","start":"2026-09-19T01:49:42.458027Z","end":"2026-09-19T01:49:43.398501Z","steps":["trace[324488137] 'agreement among raft nodes before linearized reading' (duration: 940.349424ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.398515Z","caller":"traceutil/trace.go:171","msg":"trace[1032687671] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"937.996863ms","start":"2026-09-19T01:49:42.460501Z","end":"2026-09-19T01:49:43.398498Z","steps":["trace[1032687671] 'agreement among raft nodes before linearized reading' (duration: 937.825375ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.399255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.47449Z","time spent":"923.707186ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:49:43.399314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005588681s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-19T01:49:43.39854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.458017Z","time spent":"940.516442ms","remote":"127.0.0.1:45084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/162.253.55.118\" "} {"level":"warn","ts":"2026-09-19T01:49:43.398645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.627677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:49:43.399428Z","caller":"traceutil/trace.go:171","msg":"trace[253887207] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"952.461317ms","start":"2026-09-19T01:49:42.446952Z","end":"2026-09-19T01:49:43.399413Z","steps":["trace[253887207] 'agreement among raft nodes before linearized reading' (duration: 951.641208ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.399497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.44694Z","time spent":"952.546701ms","remote":"127.0.0.1:45180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-19T01:49:43.398684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.712769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:49:43.399595Z","caller":"traceutil/trace.go:171","msg":"trace[404005801] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"953.615432ms","start":"2026-09-19T01:49:42.445935Z","end":"2026-09-19T01:49:43.39955Z","steps":["trace[404005801] 'agreement among raft nodes before linearized reading' (duration: 952.731829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.399667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.445913Z","time spent":"953.734387ms","remote":"127.0.0.1:45180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-19T01:49:43.398718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"964.236784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:49:43.399746Z","caller":"traceutil/trace.go:171","msg":"trace[715302722] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"965.260702ms","start":"2026-09-19T01:49:42.434474Z","end":"2026-09-19T01:49:43.399735Z","steps":["trace[715302722] 'agreement among raft nodes before linearized reading' (duration: 964.223683ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.399786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.434441Z","time spent":"965.335926ms","remote":"127.0.0.1:45180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-09-19T01:49:43.398917Z","caller":"traceutil/trace.go:171","msg":"trace[1875828924] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"922.905348ms","start":"2026-09-19T01:49:42.475995Z","end":"2026-09-19T01:49:43.3989Z","steps":["trace[1875828924] 'process raft request' (duration: 922.236607ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.399902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.475979Z","time spent":"923.867894ms","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:49:43.398961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005305438s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:49:43.399962Z","caller":"traceutil/trace.go:171","msg":"trace[423592807] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"1.006315305s","start":"2026-09-19T01:49:42.393636Z","end":"2026-09-19T01:49:43.399951Z","steps":["trace[423592807] 'agreement among raft nodes before linearized reading' (duration: 1.005299067s)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.399989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.393631Z","time spent":"1.006350619s","remote":"127.0.0.1:45474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-09-19T01:49:43.398958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.460771Z","time spent":"936.939663ms","remote":"127.0.0.1:45616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:49:43.398975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.329164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:49:43.400191Z","caller":"traceutil/trace.go:171","msg":"trace[167556136] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"888.560902ms","start":"2026-09-19T01:49:42.51161Z","end":"2026-09-19T01:49:43.400171Z","steps":["trace[167556136] 'agreement among raft nodes before linearized reading' (duration: 887.335643ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.400255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.511596Z","time spent":"888.642086ms","remote":"127.0.0.1:45180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-19T01:49:43.399029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.461364Z","time spent":"936.473141ms","remote":"127.0.0.1:45616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:49:43.400298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.460472Z","time spent":"938.797441ms","remote":"127.0.0.1:45180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-19T01:49:43.399081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.462076Z","time spent":"935.800098ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:49:43.399146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.462094Z","time spent":"935.874283ms","remote":"127.0.0.1:45616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:49:43.399103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.487378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-19T01:49:43.399179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.461394Z","time spent":"936.590486ms","remote":"127.0.0.1:45616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:49:43.399215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.461459Z","time spent":"936.581265ms","remote":"127.0.0.1:45616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:49:43.399775Z","caller":"traceutil/trace.go:171","msg":"trace[816537867] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:10; }","duration":"1.005682116s","start":"2026-09-19T01:49:42.393669Z","end":"2026-09-19T01:49:43.399351Z","steps":["trace[816537867] 'agreement among raft nodes before linearized reading' (duration: 1.005060966s)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.401241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.393665Z","time spent":"1.007559805s","remote":"127.0.0.1:45126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-09-19T01:49:43.401978Z","caller":"traceutil/trace.go:171","msg":"trace[2108956268] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"940.47522ms","start":"2026-09-19T01:49:42.461485Z","end":"2026-09-19T01:49:43.40196Z","steps":["trace[2108956268] 'agreement among raft nodes before linearized reading' (duration: 937.417044ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.402034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:49:42.461465Z","time spent":"940.553674ms","remote":"127.0.0.1:45150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-09-19T01:49:43.530505Z","caller":"traceutil/trace.go:171","msg":"trace[1516875988] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:13; }","duration":"123.44691ms","start":"2026-09-19T01:49:43.407027Z","end":"2026-09-19T01:49:43.530473Z","steps":["trace[1516875988] 'read index received' (duration: 111.790327ms)","trace[1516875988] 'applied index is now lower than readState.Index' (duration: 11.655393ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:49:43.530626Z","caller":"traceutil/trace.go:171","msg":"trace[1934241805] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"126.898004ms","start":"2026-09-19T01:49:43.403716Z","end":"2026-09-19T01:49:43.530614Z","steps":["trace[1934241805] 'process raft request' (duration: 115.085603ms)","trace[1934241805] 'compare' (duration: 11.472724ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:49:43.530904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.85859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-19T01:49:43.530974Z","caller":"traceutil/trace.go:171","msg":"trace[1780287173] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:11; }","duration":"123.964575ms","start":"2026-09-19T01:49:43.406993Z","end":"2026-09-19T01:49:43.530957Z","steps":["trace[1780287173] 'agreement among raft nodes before linearized reading' (duration: 123.675612ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.531072Z","caller":"traceutil/trace.go:171","msg":"trace[1489761836] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"123.620608ms","start":"2026-09-19T01:49:43.407392Z","end":"2026-09-19T01:49:43.531013Z","steps":["trace[1489761836] 'process raft request' (duration: 123.45754ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.531348Z","caller":"traceutil/trace.go:171","msg":"trace[160254763] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"115.360516ms","start":"2026-09-19T01:49:43.415974Z","end":"2026-09-19T01:49:43.531334Z","steps":["trace[160254763] 'process raft request' (duration: 115.092093ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.531496Z","caller":"traceutil/trace.go:171","msg":"trace[1793374137] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"115.225439ms","start":"2026-09-19T01:49:43.416257Z","end":"2026-09-19T01:49:43.531483Z","steps":["trace[1793374137] 'process raft request' (duration: 114.926305ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.53159Z","caller":"traceutil/trace.go:171","msg":"trace[551742343] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"115.099353ms","start":"2026-09-19T01:49:43.416476Z","end":"2026-09-19T01:49:43.531575Z","steps":["trace[551742343] 'process raft request' (duration: 114.841541ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.531751Z","caller":"traceutil/trace.go:171","msg":"trace[779462038] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"115.362346ms","start":"2026-09-19T01:49:43.416379Z","end":"2026-09-19T01:49:43.531742Z","steps":["trace[779462038] 'process raft request' (duration: 114.875103ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.531777Z","caller":"traceutil/trace.go:171","msg":"trace[1357146110] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"124.019556ms","start":"2026-09-19T01:49:43.407744Z","end":"2026-09-19T01:49:43.531764Z","steps":["trace[1357146110] 'process raft request' (duration: 123.193357ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.531821Z","caller":"traceutil/trace.go:171","msg":"trace[1866840652] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"115.166076ms","start":"2026-09-19T01:49:43.416641Z","end":"2026-09-19T01:49:43.531807Z","steps":["trace[1866840652] 'process raft request' (duration: 114.835801ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.531855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.515681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-09-19T01:49:43.531952Z","caller":"traceutil/trace.go:171","msg":"trace[1567739512] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"124.686409ms","start":"2026-09-19T01:49:43.407249Z","end":"2026-09-19T01:49:43.531936Z","steps":["trace[1567739512] 'agreement among raft nodes before linearized reading' (duration: 124.4944ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.532018Z","caller":"traceutil/trace.go:171","msg":"trace[774047474] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"115.385206ms","start":"2026-09-19T01:49:43.416558Z","end":"2026-09-19T01:49:43.531943Z","steps":["trace[774047474] 'process raft request' (duration: 114.832291ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.532109Z","caller":"traceutil/trace.go:171","msg":"trace[524118973] transaction","detail":"{read_only:false; number_of_response:0; response_revision:17; }","duration":"115.552736ms","start":"2026-09-19T01:49:43.416546Z","end":"2026-09-19T01:49:43.532099Z","steps":["trace[524118973] 'process raft request' (duration: 114.80645ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:49:43.532066Z","caller":"traceutil/trace.go:171","msg":"trace[1694668480] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"110.59435ms","start":"2026-09-19T01:49:43.42146Z","end":"2026-09-19T01:49:43.532054Z","steps":["trace[1694668480] 'process raft request' (duration: 110.181449ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:49:43.532525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.28821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-7w9h9\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-09-19T01:49:43.532574Z","caller":"traceutil/trace.go:171","msg":"trace[560457699] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-7w9h9; range_end:; response_count:1; response_revision:20; }","duration":"116.382324ms","start":"2026-09-19T01:49:43.41618Z","end":"2026-09-19T01:49:43.532562Z","steps":["trace[560457699] 'agreement among raft nodes before linearized reading' (duration: 116.27832ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:05.702968Z","caller":"traceutil/trace.go:171","msg":"trace[1864972649] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"124.832319ms","start":"2026-09-19T01:50:05.578082Z","end":"2026-09-19T01:50:05.702914Z","steps":["trace[1864972649] 'process raft request' (duration: 94.806222ms)","trace[1864972649] 'compare' (duration: 29.79667ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:05.705765Z","caller":"traceutil/trace.go:171","msg":"trace[95006393] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"127.645633ms","start":"2026-09-19T01:50:05.578083Z","end":"2026-09-19T01:50:05.705728Z","steps":["trace[95006393] 'process raft request' (duration: 127.412396ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:05.848056Z","caller":"traceutil/trace.go:171","msg":"trace[1576817521] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"139.198136ms","start":"2026-09-19T01:50:05.708799Z","end":"2026-09-19T01:50:05.847997Z","steps":["trace[1576817521] 'process raft request' (duration: 104.439879ms)","trace[1576817521] 'compare' (duration: 34.373891ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:05.848116Z","caller":"traceutil/trace.go:171","msg":"trace[1636250124] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"136.134294ms","start":"2026-09-19T01:50:05.711936Z","end":"2026-09-19T01:50:05.84807Z","steps":["trace[1636250124] 'process raft request' (duration: 135.931527ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:05.848074Z","caller":"traceutil/trace.go:171","msg":"trace[937992237] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"134.336868ms","start":"2026-09-19T01:50:05.713701Z","end":"2026-09-19T01:50:05.848038Z","steps":["trace[937992237] 'process raft request' (duration: 134.283308ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:05.848215Z","caller":"traceutil/trace.go:171","msg":"trace[647924576] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"135.884038ms","start":"2026-09-19T01:50:05.712283Z","end":"2026-09-19T01:50:05.848167Z","steps":["trace[647924576] 'process raft request' (duration: 135.659971ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:06.048468Z","caller":"traceutil/trace.go:171","msg":"trace[1564817227] linearizableReadLoop","detail":"{readStateIndex:456; appliedIndex:455; }","duration":"178.041529ms","start":"2026-09-19T01:50:05.870371Z","end":"2026-09-19T01:50:06.048412Z","steps":["trace[1564817227] 'read index received' (duration: 101.462177ms)","trace[1564817227] 'applied index is now lower than readState.Index' (duration: 76.577922ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:50:06.048628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.230847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"info","ts":"2026-09-19T01:50:06.048667Z","caller":"traceutil/trace.go:171","msg":"trace[2147457] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:444; }","duration":"178.303926ms","start":"2026-09-19T01:50:05.870349Z","end":"2026-09-19T01:50:06.048653Z","steps":["trace[2147457] 'agreement among raft nodes before linearized reading' (duration: 178.195227ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:06.048861Z","caller":"traceutil/trace.go:171","msg":"trace[1868370053] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"170.014401ms","start":"2026-09-19T01:50:05.878814Z","end":"2026-09-19T01:50:06.048829Z","steps":["trace[1868370053] 'process raft request' (duration: 169.822133ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:06.048583Z","caller":"traceutil/trace.go:171","msg":"trace[1861141425] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"180.041895ms","start":"2026-09-19T01:50:05.868476Z","end":"2026-09-19T01:50:06.048517Z","steps":["trace[1861141425] 'process raft request' (duration: 103.160566ms)","trace[1861141425] 'compare' (duration: 76.599742ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:06.284791Z","caller":"traceutil/trace.go:171","msg":"trace[2106704878] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"208.422088ms","start":"2026-09-19T01:50:06.076339Z","end":"2026-09-19T01:50:06.284761Z","steps":["trace[2106704878] 'process raft request' (duration: 208.29929ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:06.284921Z","caller":"traceutil/trace.go:171","msg":"trace[598558949] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"208.934642ms","start":"2026-09-19T01:50:06.075955Z","end":"2026-09-19T01:50:06.284889Z","steps":["trace[598558949] 'process raft request' (duration: 160.536405ms)","trace[598558949] 'compare' (duration: 47.966371ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:06.285619Z","caller":"traceutil/trace.go:171","msg":"trace[2096678539] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"158.511ms","start":"2026-09-19T01:50:06.12709Z","end":"2026-09-19T01:50:06.285601Z","steps":["trace[2096678539] 'process raft request' (duration: 158.345312ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:06.285906Z","caller":"traceutil/trace.go:171","msg":"trace[205028064] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"157.67321ms","start":"2026-09-19T01:50:06.128222Z","end":"2026-09-19T01:50:06.285896Z","steps":["trace[205028064] 'process raft request' (duration: 157.400002ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:06.286047Z","caller":"traceutil/trace.go:171","msg":"trace[20547037] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"158.696098ms","start":"2026-09-19T01:50:06.127341Z","end":"2026-09-19T01:50:06.286037Z","steps":["trace[20547037] 'process raft request' (duration: 158.193373ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:06.286198Z","caller":"traceutil/trace.go:171","msg":"trace[829539247] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"157.64635ms","start":"2026-09-19T01:50:06.128532Z","end":"2026-09-19T01:50:06.286179Z","steps":["trace[829539247] 'process raft request' (duration: 157.173555ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:14.61582Z","caller":"traceutil/trace.go:171","msg":"trace[1153728661] linearizableReadLoop","detail":"{readStateIndex:492; appliedIndex:491; }","duration":"259.371266ms","start":"2026-09-19T01:50:14.356413Z","end":"2026-09-19T01:50:14.615784Z","steps":["trace[1153728661] 'read index received' (duration: 259.277127ms)","trace[1153728661] 'applied index is now lower than readState.Index' (duration: 91.459µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:50:14.615874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:14.315695Z","time spent":"300.165322ms","remote":"127.0.0.1:45084","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-09-19T01:50:14.616025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.571305ms","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-09-19T01:50:14.61607Z","caller":"traceutil/trace.go:171","msg":"trace[1470960445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:478; }","duration":"259.669345ms","start":"2026-09-19T01:50:14.356385Z","end":"2026-09-19T01:50:14.616054Z","steps":["trace[1470960445] 'agreement among raft nodes before linearized reading' (duration: 259.537886ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:14.625059Z","caller":"traceutil/trace.go:171","msg":"trace[218836135] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"264.842618ms","start":"2026-09-19T01:50:14.360184Z","end":"2026-09-19T01:50:14.625026Z","steps":["trace[218836135] 'process raft request' (duration: 264.604838ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:16.828856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.162404ms","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-09-19T01:50:16.829192Z","caller":"traceutil/trace.go:171","msg":"trace[498605378] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:485; }","duration":"130.587152ms","start":"2026-09-19T01:50:16.698582Z","end":"2026-09-19T01:50:16.829169Z","steps":["trace[498605378] 'range keys from in-memory index tree' (duration: 129.343207ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:19.106242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.413476ms","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-09-19T01:50:19.106346Z","caller":"traceutil/trace.go:171","msg":"trace[1632686442] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:492; }","duration":"140.561755ms","start":"2026-09-19T01:50:18.965756Z","end":"2026-09-19T01:50:19.106318Z","steps":["trace[1632686442] 'range keys from in-memory index tree' (duration: 140.297426ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:23.163074Z","caller":"traceutil/trace.go:171","msg":"trace[676757707] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:513; }","duration":"181.813839ms","start":"2026-09-19T01:50:22.98123Z","end":"2026-09-19T01:50:23.163044Z","steps":["trace[676757707] 'read index received' (duration: 111.429971ms)","trace[676757707] 'applied index is now lower than readState.Index' (duration: 70.382348ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:23.16324Z","caller":"traceutil/trace.go:171","msg":"trace[1202658514] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"197.821128ms","start":"2026-09-19T01:50:22.965405Z","end":"2026-09-19T01:50:23.163226Z","steps":["trace[1202658514] 'process raft request' (duration: 127.285911ms)","trace[1202658514] 'compare' (duration: 70.225687ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:50:23.163409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.177769ms","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-09-19T01:50:23.163487Z","caller":"traceutil/trace.go:171","msg":"trace[2004711656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:499; }","duration":"182.288809ms","start":"2026-09-19T01:50:22.981173Z","end":"2026-09-19T01:50:23.163462Z","steps":["trace[2004711656] 'agreement among raft nodes before linearized reading' (duration: 182.120899ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.983187Z","caller":"traceutil/trace.go:171","msg":"trace[1830053627] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"265.4342ms","start":"2026-09-19T01:50:27.717716Z","end":"2026-09-19T01:50:27.98315Z","steps":["trace[1830053627] 'process raft request' (duration: 265.224159ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.992602Z","caller":"traceutil/trace.go:171","msg":"trace[597330614] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"271.618465ms","start":"2026-09-19T01:50:27.720958Z","end":"2026-09-19T01:50:27.992577Z","steps":["trace[597330614] 'process raft request' (duration: 270.860022ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.993425Z","caller":"traceutil/trace.go:171","msg":"trace[950555958] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"247.466762ms","start":"2026-09-19T01:50:27.745931Z","end":"2026-09-19T01:50:27.993397Z","steps":["trace[950555958] 'process raft request' (duration: 246.047967ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.993495Z","caller":"traceutil/trace.go:171","msg":"trace[137633824] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"247.407232ms","start":"2026-09-19T01:50:27.74603Z","end":"2026-09-19T01:50:27.993437Z","steps":["trace[137633824] 'process raft request' (duration: 245.982707ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.993604Z","caller":"traceutil/trace.go:171","msg":"trace[994821846] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"255.169351ms","start":"2026-09-19T01:50:27.738427Z","end":"2026-09-19T01:50:27.993596Z","steps":["trace[994821846] 'process raft request' (duration: 253.514285ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.993749Z","caller":"traceutil/trace.go:171","msg":"trace[1754269434] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"186.623847ms","start":"2026-09-19T01:50:27.807022Z","end":"2026-09-19T01:50:27.993646Z","steps":["trace[1754269434] 'process raft request' (duration: 185.182171ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.993577Z","caller":"traceutil/trace.go:171","msg":"trace[1579696401] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"267.68986ms","start":"2026-09-19T01:50:27.725872Z","end":"2026-09-19T01:50:27.993562Z","steps":["trace[1579696401] 'process raft request' (duration: 266.029494ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.994034Z","caller":"traceutil/trace.go:171","msg":"trace[1861387680] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"240.027914ms","start":"2026-09-19T01:50:27.753314Z","end":"2026-09-19T01:50:27.993342Z","steps":["trace[1861387680] 'process raft request' (duration: 238.763619ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.99411Z","caller":"traceutil/trace.go:171","msg":"trace[1410225032] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"244.704551ms","start":"2026-09-19T01:50:27.749394Z","end":"2026-09-19T01:50:27.994099Z","steps":["trace[1410225032] 'process raft request' (duration: 242.651294ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.994202Z","caller":"traceutil/trace.go:171","msg":"trace[1683764695] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"228.476578ms","start":"2026-09-19T01:50:27.765668Z","end":"2026-09-19T01:50:27.994144Z","steps":["trace[1683764695] 'process raft request' (duration: 226.444431ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:27.994356Z","caller":"traceutil/trace.go:171","msg":"trace[331054970] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"216.606992ms","start":"2026-09-19T01:50:27.77773Z","end":"2026-09-19T01:50:27.994337Z","steps":["trace[331054970] 'process raft request' (duration: 214.432464ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:28.708382Z","caller":"traceutil/trace.go:171","msg":"trace[1342148546] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"380.662001ms","start":"2026-09-19T01:50:28.327688Z","end":"2026-09-19T01:50:28.70835Z","steps":["trace[1342148546] 'process raft request' (duration: 374.831285ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:28.708493Z","caller":"traceutil/trace.go:171","msg":"trace[1145622833] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"367.232382ms","start":"2026-09-19T01:50:28.341209Z","end":"2026-09-19T01:50:28.708441Z","steps":["trace[1145622833] 'process raft request' (duration: 366.966711ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:28.708585Z","caller":"traceutil/trace.go:171","msg":"trace[1893473246] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"350.93475ms","start":"2026-09-19T01:50:28.357623Z","end":"2026-09-19T01:50:28.708558Z","steps":["trace[1893473246] 'process raft request' (duration: 350.648968ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:28.708665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:28.34118Z","time spent":"367.409964ms","remote":"127.0.0.1:45096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:50:28.70883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:28.327662Z","time spent":"380.863974ms","remote":"127.0.0.1:45096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:50:28.708859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:28.35761Z","time spent":"351.05093ms","remote":"127.0.0.1:45096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:50:34.557363Z","caller":"traceutil/trace.go:171","msg":"trace[1024592944] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"868.22307ms","start":"2026-09-19T01:50:33.689101Z","end":"2026-09-19T01:50:34.557324Z","steps":["trace[1024592944] 'process raft request' (duration: 868.045068ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:34.55767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:33.689075Z","time spent":"868.477481ms","remote":"127.0.0.1:45168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1749,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:50:34.634571Z","caller":"traceutil/trace.go:171","msg":"trace[1710029806] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"944.26365ms","start":"2026-09-19T01:50:33.690271Z","end":"2026-09-19T01:50:34.634535Z","steps":["trace[1710029806] 'process raft request' (duration: 943.799657ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:34.634838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:33.690241Z","time spent":"944.518833ms","remote":"127.0.0.1:45276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T01:50:34.634816Z","caller":"traceutil/trace.go:171","msg":"trace[2069689807] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:659; }","duration":"318.476506ms","start":"2026-09-19T01:50:34.316305Z","end":"2026-09-19T01:50:34.634782Z","steps":["trace[2069689807] 'read index received' (duration: 241.487668ms)","trace[2069689807] 'applied index is now lower than readState.Index' (duration: 76.987568ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:50:34.635014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.682657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.118\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-19T01:50:34.635057Z","caller":"traceutil/trace.go:171","msg":"trace[443243028] range","detail":"{range_begin:/registry/masterleases/162.253.55.118; range_end:; response_count:1; response_revision:638; }","duration":"318.806319ms","start":"2026-09-19T01:50:34.31624Z","end":"2026-09-19T01:50:34.635047Z","steps":["trace[443243028] 'agreement among raft nodes before linearized reading' (duration: 318.663708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:34.635097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:34.316211Z","time spent":"318.878179ms","remote":"127.0.0.1:45084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.118\" "} {"level":"info","ts":"2026-09-19T01:50:34.635414Z","caller":"traceutil/trace.go:171","msg":"trace[545676306] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"551.520877ms","start":"2026-09-19T01:50:34.083823Z","end":"2026-09-19T01:50:34.635343Z","steps":["trace[545676306] 'process raft request' (duration: 550.67307ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:34.635669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:34.083796Z","time spent":"551.73974ms","remote":"127.0.0.1:45154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:50:34.87476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.812212ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:50:34.87492Z","caller":"traceutil/trace.go:171","msg":"trace[553548130] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"141.274514ms","start":"2026-09-19T01:50:34.733622Z","end":"2026-09-19T01:50:34.874897Z","steps":["trace[553548130] 'read index received' (duration: 97.241µs)","trace[553548130] 'applied index is now lower than readState.Index' (duration: 141.175653ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:34.874951Z","caller":"traceutil/trace.go:171","msg":"trace[480163199] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"218.361483ms","start":"2026-09-19T01:50:34.656546Z","end":"2026-09-19T01:50:34.874908Z","steps":["trace[480163199] 'process raft request' (duration: 16.970266ms)","trace[480163199] 'compare' (duration: 200.56325ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:50:34.875065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.453675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:50:34.875118Z","caller":"traceutil/trace.go:171","msg":"trace[7564443] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:639; }","duration":"141.553507ms","start":"2026-09-19T01:50:34.733544Z","end":"2026-09-19T01:50:34.875098Z","steps":["trace[7564443] 'agreement among raft nodes before linearized reading' (duration: 141.416306ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:35.533358Z","caller":"traceutil/trace.go:171","msg":"trace[1874388176] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"283.536456ms","start":"2026-09-19T01:50:35.249783Z","end":"2026-09-19T01:50:35.53332Z","steps":["trace[1874388176] 'process raft request' (duration: 193.134349ms)","trace[1874388176] 'compare' (duration: 90.097485ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:36.081855Z","caller":"traceutil/trace.go:171","msg":"trace[1764708613] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:670; }","duration":"708.456536ms","start":"2026-09-19T01:50:35.373376Z","end":"2026-09-19T01:50:36.081833Z","steps":["trace[1764708613] 'read index received' (duration: 69.638857ms)","trace[1764708613] 'applied index is now lower than readState.Index' (duration: 638.816889ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:36.081942Z","caller":"traceutil/trace.go:171","msg":"trace[1293402569] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"807.568908ms","start":"2026-09-19T01:50:35.274339Z","end":"2026-09-19T01:50:36.081908Z","steps":["trace[1293402569] 'process raft request' (duration: 806.885361ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:36.082165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.742679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-g2kxf\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-19T01:50:36.082281Z","caller":"traceutil/trace.go:171","msg":"trace[764892617] range","detail":"{range_begin:/registry/pods/kube-system/cilium-g2kxf; range_end:; response_count:1; response_revision:648; }","duration":"708.911881ms","start":"2026-09-19T01:50:35.37334Z","end":"2026-09-19T01:50:36.082252Z","steps":["trace[764892617] 'agreement among raft nodes before linearized reading' (duration: 708.631609ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:36.082282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:35.274328Z","time spent":"807.86108ms","remote":"127.0.0.1:45154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:50:36.082337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:35.373293Z","time spent":"709.035222ms","remote":"127.0.0.1:45264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-g2kxf\" "} {"level":"info","ts":"2026-09-19T01:50:37.033966Z","caller":"traceutil/trace.go:171","msg":"trace[1109867790] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"933.421198ms","start":"2026-09-19T01:50:36.100406Z","end":"2026-09-19T01:50:37.033827Z","steps":["trace[1109867790] 'process raft request' (duration: 933.229916ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:37.034319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:36.100378Z","time spent":"933.848323ms","remote":"127.0.0.1:45264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:50:37.034634Z","caller":"traceutil/trace.go:171","msg":"trace[1396558863] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"175.349389ms","start":"2026-09-19T01:50:36.85927Z","end":"2026-09-19T01:50:37.034619Z","steps":["trace[1396558863] 'process raft request' (duration: 175.303799ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:37.034812Z","caller":"traceutil/trace.go:171","msg":"trace[182222042] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"876.602859ms","start":"2026-09-19T01:50:36.158109Z","end":"2026-09-19T01:50:37.034712Z","steps":["trace[182222042] 'process raft request' (duration: 876.397417ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:37.035397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:36.158067Z","time spent":"877.163795ms","remote":"127.0.0.1:45276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:50:37.579083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1190815860849930607,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-19T01:50:37.615398Z","caller":"traceutil/trace.go:171","msg":"trace[1826316431] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"543.582473ms","start":"2026-09-19T01:50:37.07179Z","end":"2026-09-19T01:50:37.615372Z","steps":["trace[1826316431] 'process raft request' (duration: 524.069274ms)","trace[1826316431] 'compare' (duration: 18.935124ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:50:37.615531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:37.071764Z","time spent":"543.694965ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:50:37.615913Z","caller":"traceutil/trace.go:171","msg":"trace[1538137515] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:675; }","duration":"537.797298ms","start":"2026-09-19T01:50:37.078094Z","end":"2026-09-19T01:50:37.615891Z","steps":["trace[1538137515] 'read index received' (duration: 517.862105ms)","trace[1538137515] 'applied index is now lower than readState.Index' (duration: 19.934273ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:50:37.616024Z","caller":"traceutil/trace.go:171","msg":"trace[621743472] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"121.566136ms","start":"2026-09-19T01:50:37.494448Z","end":"2026-09-19T01:50:37.616014Z","steps":["trace[621743472] 'process raft request' (duration: 120.92808ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:37.616179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.577618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-19T01:50:37.616216Z","caller":"traceutil/trace.go:171","msg":"trace[1932858565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:653; }","duration":"374.615429ms","start":"2026-09-19T01:50:37.241588Z","end":"2026-09-19T01:50:37.616204Z","steps":["trace[1932858565] 'agreement among raft nodes before linearized reading' (duration: 374.479337ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:37.616239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:37.241514Z","time spent":"374.718249ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-19T01:50:37.616414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.321053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:50:37.616434Z","caller":"traceutil/trace.go:171","msg":"trace[572071315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"538.338874ms","start":"2026-09-19T01:50:37.078087Z","end":"2026-09-19T01:50:37.616425Z","steps":["trace[572071315] 'agreement among raft nodes before linearized reading' (duration: 538.305523ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:37.61645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:37.078042Z","time spent":"538.403715ms","remote":"127.0.0.1:45048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T01:50:37.617219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.391007ms","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-09-19T01:50:37.617376Z","caller":"traceutil/trace.go:171","msg":"trace[1997480915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:653; }","duration":"369.622679ms","start":"2026-09-19T01:50:37.247724Z","end":"2026-09-19T01:50:37.617347Z","steps":["trace[1997480915] 'agreement among raft nodes before linearized reading' (duration: 368.57627ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:37.617474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:37.247703Z","time spent":"369.754402ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-19T01:50:55.531009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.766755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-19T01:50:55.53156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.6483ms","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-09-19T01:50:55.531687Z","caller":"traceutil/trace.go:171","msg":"trace[1044109948] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:830; }","duration":"215.868024ms","start":"2026-09-19T01:50:55.315796Z","end":"2026-09-19T01:50:55.531664Z","steps":["trace[1044109948] 'range keys from in-memory index tree' (duration: 215.355905ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:55.531153Z","caller":"traceutil/trace.go:171","msg":"trace[76700988] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:830; }","duration":"551.986499ms","start":"2026-09-19T01:50:54.979141Z","end":"2026-09-19T01:50:55.531128Z","steps":["trace[76700988] 'count revisions from in-memory index tree' (duration: 551.668073ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:50:55.532119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:50:54.979112Z","time spent":"552.923415ms","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"info","ts":"2026-09-19T01:50:55.636909Z","caller":"traceutil/trace.go:171","msg":"trace[1325016958] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"121.991922ms","start":"2026-09-19T01:50:55.514872Z","end":"2026-09-19T01:50:55.636863Z","steps":["trace[1325016958] 'process raft request' (duration: 121.791218ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:50:55.646433Z","caller":"traceutil/trace.go:171","msg":"trace[114412197] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"107.890966ms","start":"2026-09-19T01:50:55.538503Z","end":"2026-09-19T01:50:55.646394Z","steps":["trace[114412197] 'process raft request' (duration: 107.660062ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:27.987279Z","caller":"traceutil/trace.go:171","msg":"trace[2033047354] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"113.562598ms","start":"2026-09-19T01:51:27.873655Z","end":"2026-09-19T01:51:27.987217Z","steps":["trace[2033047354] 'process raft request' (duration: 113.27659ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:47.021993Z","caller":"traceutil/trace.go:171","msg":"trace[136189139] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"161.694056ms","start":"2026-09-19T01:51:46.860246Z","end":"2026-09-19T01:51:47.02194Z","steps":["trace[136189139] 'process raft request' (duration: 160.773326ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:51.902361Z","caller":"traceutil/trace.go:171","msg":"trace[992229493] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"130.522798ms","start":"2026-09-19T01:51:51.771787Z","end":"2026-09-19T01:51:51.90231Z","steps":["trace[992229493] 'process raft request' (duration: 71.521907ms)","trace[992229493] 'compare' (duration: 58.722652ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:51:51.903249Z","caller":"traceutil/trace.go:171","msg":"trace[2036262011] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"131.408237ms","start":"2026-09-19T01:51:51.771798Z","end":"2026-09-19T01:51:51.903206Z","steps":["trace[2036262011] 'process raft request' (duration: 130.470357ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:51.907966Z","caller":"traceutil/trace.go:171","msg":"trace[1532239021] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"102.837489ms","start":"2026-09-19T01:51:51.805105Z","end":"2026-09-19T01:51:51.907942Z","steps":["trace[1532239021] 'process raft request' (duration: 102.720795ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:53.01032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.849561ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:51:53.010444Z","caller":"traceutil/trace.go:171","msg":"trace[415659469] linearizableReadLoop","detail":"{readStateIndex:1540; appliedIndex:1539; }","duration":"210.821183ms","start":"2026-09-19T01:51:52.799601Z","end":"2026-09-19T01:51:53.010422Z","steps":["trace[415659469] 'read index received' (duration: 47.740035ms)","trace[415659469] 'applied index is now lower than readState.Index' (duration: 163.079058ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:51:53.01058Z","caller":"traceutil/trace.go:171","msg":"trace[886270802] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"225.456542ms","start":"2026-09-19T01:51:52.785067Z","end":"2026-09-19T01:51:53.010523Z","steps":["trace[886270802] 'process raft request' (duration: 62.290351ms)","trace[886270802] 'compare' (duration: 162.634984ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:51:53.010678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.063891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/ingress-nginx/ingress-nginx-admission\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:51:53.010797Z","caller":"traceutil/trace.go:171","msg":"trace[468820155] range","detail":"{range_begin:/registry/rolebindings/ingress-nginx/ingress-nginx-admission; range_end:; response_count:0; response_revision:1490; }","duration":"211.198095ms","start":"2026-09-19T01:51:52.799542Z","end":"2026-09-19T01:51:53.01074Z","steps":["trace[468820155] 'agreement among raft nodes before linearized reading' (duration: 211.012389ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:53.769838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.074289ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:51:53.770075Z","caller":"traceutil/trace.go:171","msg":"trace[1550866061] transaction","detail":"{read_only:false; response_revision:1499; number_of_response:1; }","duration":"313.325009ms","start":"2026-09-19T01:51:53.456733Z","end":"2026-09-19T01:51:53.770058Z","steps":["trace[1550866061] 'process raft request' (duration: 313.216405ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:53.770072Z","caller":"traceutil/trace.go:171","msg":"trace[44331522] transaction","detail":"{read_only:false; response_revision:1498; number_of_response:1; }","duration":"313.390791ms","start":"2026-09-19T01:51:53.456653Z","end":"2026-09-19T01:51:53.770044Z","steps":["trace[44331522] 'process raft request' (duration: 156.947719ms)","trace[44331522] 'compare' (duration: 155.934494ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:51:53.770159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:51:53.456683Z","time spent":"313.439323ms","remote":"127.0.0.1:45134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:51:53.770181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:51:53.456616Z","time spent":"313.518965ms","remote":"127.0.0.1:45264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3246,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:51:53.786091Z","caller":"traceutil/trace.go:171","msg":"trace[44613230] linearizableReadLoop","detail":"{readStateIndex:1550; appliedIndex:1547; }","duration":"223.461661ms","start":"2026-09-19T01:51:53.562604Z","end":"2026-09-19T01:51:53.786066Z","steps":["trace[44613230] 'read index received' (duration: 51.098875ms)","trace[44613230] 'applied index is now lower than readState.Index' (duration: 172.361246ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:51:53.786431Z","caller":"traceutil/trace.go:171","msg":"trace[519237219] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"328.037762ms","start":"2026-09-19T01:51:53.458334Z","end":"2026-09-19T01:51:53.786372Z","steps":["trace[519237219] 'process raft request' (duration: 327.605828ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:53.786525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.902567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-19T01:51:53.786558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:51:53.45832Z","time spent":"328.169938ms","remote":"127.0.0.1:45318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:51:53.786588Z","caller":"traceutil/trace.go:171","msg":"trace[290516166] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1500; }","duration":"224.0218ms","start":"2026-09-19T01:51:53.562548Z","end":"2026-09-19T01:51:53.786569Z","steps":["trace[290516166] 'agreement among raft nodes before linearized reading' (duration: 223.891975ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:54.044033Z","caller":"traceutil/trace.go:171","msg":"trace[762486106] linearizableReadLoop","detail":"{readStateIndex:1551; appliedIndex:1550; }","duration":"257.839542ms","start":"2026-09-19T01:51:53.786175Z","end":"2026-09-19T01:51:54.044014Z","steps":["trace[762486106] 'read index received' (duration: 257.685267ms)","trace[762486106] 'applied index is now lower than readState.Index' (duration: 153.205µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:51:54.044084Z","caller":"traceutil/trace.go:171","msg":"trace[1911557579] transaction","detail":"{read_only:false; response_revision:1501; number_of_response:1; }","duration":"268.919605ms","start":"2026-09-19T01:51:53.775137Z","end":"2026-09-19T01:51:54.044057Z","steps":["trace[1911557579] 'process raft request' (duration: 268.749069ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:54.044257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.440955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-dzqqz\" ","response":"range_response_count:1 size:3261"} {"level":"warn","ts":"2026-09-19T01:51:54.044255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.689714ms","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-09-19T01:51:54.044291Z","caller":"traceutil/trace.go:171","msg":"trace[1279219584] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-patch-dzqqz; range_end:; response_count:1; response_revision:1501; }","duration":"267.523908ms","start":"2026-09-19T01:51:53.776753Z","end":"2026-09-19T01:51:54.044277Z","steps":["trace[1279219584] 'agreement among raft nodes before linearized reading' (duration: 267.366313ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:54.044314Z","caller":"traceutil/trace.go:171","msg":"trace[1858431207] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1501; }","duration":"169.806277ms","start":"2026-09-19T01:51:53.874491Z","end":"2026-09-19T01:51:54.044297Z","steps":["trace[1858431207] 'agreement among raft nodes before linearized reading' (duration: 169.667623ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:54.488023Z","caller":"traceutil/trace.go:171","msg":"trace[659240984] transaction","detail":"{read_only:false; response_revision:1507; number_of_response:1; }","duration":"116.166199ms","start":"2026-09-19T01:51:54.371812Z","end":"2026-09-19T01:51:54.487978Z","steps":["trace[659240984] 'process raft request' (duration: 115.3334ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:54.529428Z","caller":"traceutil/trace.go:171","msg":"trace[1856592707] transaction","detail":"{read_only:false; response_revision:1508; number_of_response:1; }","duration":"136.019028ms","start":"2026-09-19T01:51:54.393373Z","end":"2026-09-19T01:51:54.529392Z","steps":["trace[1856592707] 'process raft request' (duration: 135.78354ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:54.529708Z","caller":"traceutil/trace.go:171","msg":"trace[876482514] transaction","detail":"{read_only:false; response_revision:1509; number_of_response:1; }","duration":"135.717108ms","start":"2026-09-19T01:51:54.393952Z","end":"2026-09-19T01:51:54.529669Z","steps":["trace[876482514] 'process raft request' (duration: 135.376807ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:51:58.609524Z","caller":"traceutil/trace.go:171","msg":"trace[1784057561] linearizableReadLoop","detail":"{readStateIndex:1578; appliedIndex:1577; }","duration":"121.176932ms","start":"2026-09-19T01:51:58.488323Z","end":"2026-09-19T01:51:58.6095Z","steps":["trace[1784057561] 'read index received' (duration: 120.83716ms)","trace[1784057561] 'applied index is now lower than readState.Index' (duration: 338.412µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:51:58.609593Z","caller":"traceutil/trace.go:171","msg":"trace[2053270202] transaction","detail":"{read_only:false; response_revision:1527; number_of_response:1; }","duration":"222.949339ms","start":"2026-09-19T01:51:58.386599Z","end":"2026-09-19T01:51:58.609549Z","steps":["trace[2053270202] 'process raft request' (duration: 222.484183ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:58.609872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.507454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:51:58.610647Z","caller":"traceutil/trace.go:171","msg":"trace[1921245108] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1527; }","duration":"122.335272ms","start":"2026-09-19T01:51:58.488279Z","end":"2026-09-19T01:51:58.610615Z","steps":["trace[1921245108] 'agreement among raft nodes before linearized reading' (duration: 121.384209ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:51:58.6112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.790727ms","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-09-19T01:51:58.61144Z","caller":"traceutil/trace.go:171","msg":"trace[1765081412] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1527; }","duration":"109.075967ms","start":"2026-09-19T01:51:58.502345Z","end":"2026-09-19T01:51:58.611421Z","steps":["trace[1765081412] 'agreement among raft nodes before linearized reading' (duration: 108.067453ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:26.970839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.563283ms","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-09-19T01:52:26.97097Z","caller":"traceutil/trace.go:171","msg":"trace[1993944111] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1945; }","duration":"169.761941ms","start":"2026-09-19T01:52:26.801181Z","end":"2026-09-19T01:52:26.970943Z","steps":["trace[1993944111] 'range keys from in-memory index tree' (duration: 169.368775ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:26.971027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.038402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-19T01:52:26.970864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.495375ms","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-09-19T01:52:26.971508Z","caller":"traceutil/trace.go:171","msg":"trace[1740016093] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1945; }","duration":"119.201731ms","start":"2026-09-19T01:52:26.85227Z","end":"2026-09-19T01:52:26.971472Z","steps":["trace[1740016093] 'range keys from in-memory index tree' (duration: 118.245086ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:26.971407Z","caller":"traceutil/trace.go:171","msg":"trace[1752202464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1945; }","duration":"129.354574ms","start":"2026-09-19T01:52:26.841974Z","end":"2026-09-19T01:52:26.971328Z","steps":["trace[1752202464] 'range keys from in-memory index tree' (duration: 128.822655ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:27.446098Z","caller":"traceutil/trace.go:171","msg":"trace[1907929953] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"470.391816ms","start":"2026-09-19T01:52:26.975678Z","end":"2026-09-19T01:52:27.44607Z","steps":["trace[1907929953] 'process raft request' (duration: 470.220089ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:27.44642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:52:26.975653Z","time spent":"470.554912ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:52:27.658988Z","caller":"traceutil/trace.go:171","msg":"trace[644433665] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"682.831537ms","start":"2026-09-19T01:52:26.976126Z","end":"2026-09-19T01:52:27.658957Z","steps":["trace[644433665] 'process raft request' (duration: 682.612849ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:27.659301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:52:26.976109Z","time spent":"683.070847ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:52:27.659463Z","caller":"traceutil/trace.go:171","msg":"trace[1692775908] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"682.634881ms","start":"2026-09-19T01:52:26.976801Z","end":"2026-09-19T01:52:27.659436Z","steps":["trace[1692775908] 'process raft request' (duration: 682.552598ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:27.65956Z","caller":"traceutil/trace.go:171","msg":"trace[1923099077] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"683.159431ms","start":"2026-09-19T01:52:26.976361Z","end":"2026-09-19T01:52:27.659521Z","steps":["trace[1923099077] 'process raft request' (duration: 682.536707ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:27.659644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:52:26.976786Z","time spent":"682.753196ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:52:27.65974Z","caller":"traceutil/trace.go:171","msg":"trace[262661619] linearizableReadLoop","detail":"{readStateIndex:2028; appliedIndex:2023; }","duration":"653.880944ms","start":"2026-09-19T01:52:27.00583Z","end":"2026-09-19T01:52:27.659711Z","steps":["trace[262661619] 'read index received' (duration: 440.151853ms)","trace[262661619] 'applied index is now lower than readState.Index' (duration: 213.727851ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:52:27.659787Z","caller":"traceutil/trace.go:171","msg":"trace[1643720754] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"683.226784ms","start":"2026-09-19T01:52:26.976549Z","end":"2026-09-19T01:52:27.659776Z","steps":["trace[1643720754] 'process raft request' (duration: 682.672113ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:27.659854Z","caller":"traceutil/trace.go:171","msg":"trace[1728936261] transaction","detail":"{read_only:false; response_revision:1951; number_of_response:1; }","duration":"291.734984ms","start":"2026-09-19T01:52:27.368108Z","end":"2026-09-19T01:52:27.659843Z","steps":["trace[1728936261] 'process raft request' (duration: 291.284827ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:27.659915Z","caller":"traceutil/trace.go:171","msg":"trace[1790864664] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"271.687245ms","start":"2026-09-19T01:52:27.388209Z","end":"2026-09-19T01:52:27.659896Z","steps":["trace[1790864664] 'process raft request' (duration: 271.346322ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:27.659863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:52:26.976542Z","time spent":"683.293116ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:52:27.659774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:52:26.97634Z","time spent":"683.322296ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:52:27.660048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.226347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-be149f37-08e0-4d4e-ab2c-9745e561777b\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-19T01:52:27.660082Z","caller":"traceutil/trace.go:171","msg":"trace[1028360513] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-be149f37-08e0-4d4e-ab2c-9745e561777b; range_end:; response_count:1; response_revision:1953; }","duration":"654.28307ms","start":"2026-09-19T01:52:27.005789Z","end":"2026-09-19T01:52:27.660072Z","steps":["trace[1028360513] 'agreement among raft nodes before linearized reading' (duration: 654.122384ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:27.660118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:52:27.005775Z","time spent":"654.336481ms","remote":"127.0.0.1:45264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-be149f37-08e0-4d4e-ab2c-9745e561777b\" "} {"level":"warn","ts":"2026-09-19T01:52:27.660461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.75059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-be149f37-08e0-4d4e-ab2c-9745e561777b\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-19T01:52:27.660522Z","caller":"traceutil/trace.go:171","msg":"trace[274043936] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-be149f37-08e0-4d4e-ab2c-9745e561777b; range_end:; response_count:1; response_revision:1953; }","duration":"494.866515ms","start":"2026-09-19T01:52:27.16564Z","end":"2026-09-19T01:52:27.660506Z","steps":["trace[274043936] 'agreement among raft nodes before linearized reading' (duration: 494.450078ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:27.660545Z","caller":"traceutil/trace.go:171","msg":"trace[668875402] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"232.192921ms","start":"2026-09-19T01:52:27.428338Z","end":"2026-09-19T01:52:27.660531Z","steps":["trace[668875402] 'process raft request' (duration: 231.315727ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:27.660575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:52:27.165611Z","time spent":"494.948398ms","remote":"127.0.0.1:45264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-be149f37-08e0-4d4e-ab2c-9745e561777b\" "} {"level":"warn","ts":"2026-09-19T01:52:27.660855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.96448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-19T01:52:27.660909Z","caller":"traceutil/trace.go:171","msg":"trace[776646122] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1953; }","duration":"298.060144ms","start":"2026-09-19T01:52:27.362832Z","end":"2026-09-19T01:52:27.660893Z","steps":["trace[776646122] 'agreement among raft nodes before linearized reading' (duration: 297.900498ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:27.810829Z","caller":"traceutil/trace.go:171","msg":"trace[1841256811] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"139.702059ms","start":"2026-09-19T01:52:27.671097Z","end":"2026-09-19T01:52:27.810799Z","steps":["trace[1841256811] 'process raft request' (duration: 139.510222ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:28.27878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.535091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:52:28.278872Z","caller":"traceutil/trace.go:171","msg":"trace[1064843621] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1954; }","duration":"200.673286ms","start":"2026-09-19T01:52:28.078176Z","end":"2026-09-19T01:52:28.27885Z","steps":["trace[1064843621] 'range keys from in-memory index tree' (duration: 200.444787ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:42.749838Z","caller":"traceutil/trace.go:171","msg":"trace[993285062] linearizableReadLoop","detail":"{readStateIndex:2162; appliedIndex:2161; }","duration":"149.459219ms","start":"2026-09-19T01:52:42.600345Z","end":"2026-09-19T01:52:42.749804Z","steps":["trace[993285062] 'read index received' (duration: 149.24068ms)","trace[993285062] 'applied index is now lower than readState.Index' (duration: 217.088µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:52:42.750238Z","caller":"traceutil/trace.go:171","msg":"trace[1225361506] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"174.646465ms","start":"2026-09-19T01:52:42.575548Z","end":"2026-09-19T01:52:42.750195Z","steps":["trace[1225361506] 'process raft request' (duration: 174.051261ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:52:42.750562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.179927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:108823"} {"level":"info","ts":"2026-09-19T01:52:42.751245Z","caller":"traceutil/trace.go:171","msg":"trace[298548681] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2080; }","duration":"150.356243ms","start":"2026-09-19T01:52:42.600302Z","end":"2026-09-19T01:52:42.750658Z","steps":["trace[298548681] 'agreement among raft nodes before linearized reading' (duration: 149.864034ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:52:56.993696Z","caller":"traceutil/trace.go:171","msg":"trace[1244878346] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"111.730967ms","start":"2026-09-19T01:52:56.881931Z","end":"2026-09-19T01:52:56.993662Z","steps":["trace[1244878346] 'process raft request' (duration: 105.592732ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:53:02.61061Z","caller":"traceutil/trace.go:171","msg":"trace[1792784284] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"138.987158ms","start":"2026-09-19T01:53:02.471583Z","end":"2026-09-19T01:53:02.61057Z","steps":["trace[1792784284] 'process raft request' (duration: 138.732218ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:53:03.046451Z","caller":"traceutil/trace.go:171","msg":"trace[873381464] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"149.677012ms","start":"2026-09-19T01:53:02.896079Z","end":"2026-09-19T01:53:03.045756Z","steps":["trace[873381464] 'process raft request' (duration: 149.333109ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:53:03.860906Z","caller":"traceutil/trace.go:171","msg":"trace[905970261] linearizableReadLoop","detail":"{readStateIndex:2287; appliedIndex:2286; }","duration":"121.182005ms","start":"2026-09-19T01:53:03.739696Z","end":"2026-09-19T01:53:03.860878Z","steps":["trace[905970261] 'read index received' (duration: 120.978187ms)","trace[905970261] 'applied index is now lower than readState.Index' (duration: 202.338µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:53:03.860971Z","caller":"traceutil/trace.go:171","msg":"trace[814488569] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"180.604111ms","start":"2026-09-19T01:53:03.680338Z","end":"2026-09-19T01:53:03.860942Z","steps":["trace[814488569] 'process raft request' (duration: 180.312369ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:03.861688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.962297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-09-19T01:53:03.861788Z","caller":"traceutil/trace.go:171","msg":"trace[360270263] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2200; }","duration":"122.124554ms","start":"2026-09-19T01:53:03.739643Z","end":"2026-09-19T01:53:03.861767Z","steps":["trace[360270263] 'agreement among raft nodes before linearized reading' (duration: 121.350732ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:04.432192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.077818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:53:04.432576Z","caller":"traceutil/trace.go:171","msg":"trace[1312160958] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"565.250194ms","start":"2026-09-19T01:53:03.867229Z","end":"2026-09-19T01:53:04.432479Z","steps":["trace[1312160958] 'process raft request' (duration: 79.771869ms)","trace[1312160958] 'compare' (duration: 484.6003ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:53:04.432686Z","caller":"traceutil/trace.go:171","msg":"trace[1126005675] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"541.794244ms","start":"2026-09-19T01:53:03.890835Z","end":"2026-09-19T01:53:04.432629Z","steps":["trace[1126005675] 'process raft request' (duration: 541.480231ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:53:04.432797Z","caller":"traceutil/trace.go:171","msg":"trace[1411403080] linearizableReadLoop","detail":"{readStateIndex:2290; appliedIndex:2288; }","duration":"510.984837ms","start":"2026-09-19T01:53:03.921471Z","end":"2026-09-19T01:53:04.432455Z","steps":["trace[1411403080] 'read index received' (duration: 25.536523ms)","trace[1411403080] 'applied index is now lower than readState.Index' (duration: 485.446744ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:53:04.432981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:53:03.890803Z","time spent":"542.013903ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:53:04.433075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.598552ms","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-09-19T01:53:04.433087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:53:03.867208Z","time spent":"565.584627ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:53:04.433153Z","caller":"traceutil/trace.go:171","msg":"trace[1436208498] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2203; }","duration":"511.675035ms","start":"2026-09-19T01:53:03.921429Z","end":"2026-09-19T01:53:04.433104Z","steps":["trace[1436208498] 'agreement among raft nodes before linearized reading' (duration: 511.474926ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:04.433201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:53:03.921416Z","time spent":"511.774629ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-19T01:53:04.433354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.688632ms","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-09-19T01:53:04.433478Z","caller":"traceutil/trace.go:171","msg":"trace[1130160467] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2203; }","duration":"503.877529ms","start":"2026-09-19T01:53:03.929569Z","end":"2026-09-19T01:53:04.433446Z","steps":["trace[1130160467] 'agreement among raft nodes before linearized reading' (duration: 503.513565ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:04.433548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:53:03.92956Z","time spent":"503.973523ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-19T01:53:04.433556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.330285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-19T01:53:04.433628Z","caller":"traceutil/trace.go:171","msg":"trace[1669353297] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2203; }","duration":"379.398718ms","start":"2026-09-19T01:53:04.054207Z","end":"2026-09-19T01:53:04.433606Z","steps":["trace[1669353297] 'agreement among raft nodes before linearized reading' (duration: 379.156999ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:04.433586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.447227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.118\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-09-19T01:53:04.433691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:53:04.054128Z","time spent":"379.550124ms","remote":"127.0.0.1:41166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-19T01:53:04.433681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.457456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:53:04.433784Z","caller":"traceutil/trace.go:171","msg":"trace[1238785429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2203; }","duration":"354.559281ms","start":"2026-09-19T01:53:04.079184Z","end":"2026-09-19T01:53:04.433744Z","steps":["trace[1238785429] 'agreement among raft nodes before linearized reading' (duration: 354.423495ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:53:04.433737Z","caller":"traceutil/trace.go:171","msg":"trace[677002548] range","detail":"{range_begin:/registry/masterleases/162.253.55.118; range_end:; response_count:1; response_revision:2203; }","duration":"108.663385ms","start":"2026-09-19T01:53:04.325024Z","end":"2026-09-19T01:53:04.433687Z","steps":["trace[677002548] 'agreement among raft nodes before linearized reading' (duration: 108.366353ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:04.433833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.139938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-19T01:53:04.433893Z","caller":"traceutil/trace.go:171","msg":"trace[1906920049] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2203; }","duration":"502.213632ms","start":"2026-09-19T01:53:03.93166Z","end":"2026-09-19T01:53:04.433874Z","steps":["trace[1906920049] 'agreement among raft nodes before linearized reading' (duration: 502.054256ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:04.433941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:53:03.93165Z","time spent":"502.279385ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-09-19T01:53:04.433944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:53:04.079171Z","time spent":"354.762648ms","remote":"127.0.0.1:45048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T01:53:04.434233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.17077ms","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-09-19T01:53:04.434293Z","caller":"traceutil/trace.go:171","msg":"trace[1961439412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2203; }","duration":"503.278304ms","start":"2026-09-19T01:53:03.930997Z","end":"2026-09-19T01:53:04.434275Z","steps":["trace[1961439412] 'agreement among raft nodes before linearized reading' (duration: 503.041655ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:53:04.434334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:53:03.930971Z","time spent":"503.351457ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-19T01:54:09.247729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.15983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:54:09.247831Z","caller":"traceutil/trace.go:171","msg":"trace[455333312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2657; }","duration":"168.305846ms","start":"2026-09-19T01:54:09.079503Z","end":"2026-09-19T01:54:09.247809Z","steps":["trace[455333312] 'range keys from in-memory index tree' (duration: 168.055065ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:54:09.247885Z","caller":"traceutil/trace.go:171","msg":"trace[2027744082] transaction","detail":"{read_only:false; response_revision:2658; number_of_response:1; }","duration":"117.054248ms","start":"2026-09-19T01:54:09.130811Z","end":"2026-09-19T01:54:09.247865Z","steps":["trace[2027744082] 'process raft request' (duration: 116.685942ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:54:39.546041Z","caller":"traceutil/trace.go:171","msg":"trace[949242290] linearizableReadLoop","detail":"{readStateIndex:2931; appliedIndex:2930; }","duration":"539.068953ms","start":"2026-09-19T01:54:39.006944Z","end":"2026-09-19T01:54:39.546013Z","steps":["trace[949242290] 'read index received' (duration: 474.448721ms)","trace[949242290] 'applied index is now lower than readState.Index' (duration: 64.618852ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:54:39.546196Z","caller":"traceutil/trace.go:171","msg":"trace[221912741] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"554.392329ms","start":"2026-09-19T01:54:38.991786Z","end":"2026-09-19T01:54:39.546178Z","steps":["trace[221912741] 'process raft request' (duration: 489.494575ms)","trace[221912741] 'compare' (duration: 64.236608ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:54:39.546334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:38.991746Z","time spent":"554.48408ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:54:39.546675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.725368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-09-19T01:54:39.546818Z","caller":"traceutil/trace.go:171","msg":"trace[1619378563] transaction","detail":"{read_only:false; response_revision:2824; number_of_response:1; }","duration":"261.176695ms","start":"2026-09-19T01:54:39.285626Z","end":"2026-09-19T01:54:39.546803Z","steps":["trace[1619378563] 'process raft request' (duration: 260.263825ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:54:39.546734Z","caller":"traceutil/trace.go:171","msg":"trace[1734899812] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2824; }","duration":"539.809639ms","start":"2026-09-19T01:54:39.006909Z","end":"2026-09-19T01:54:39.546719Z","steps":["trace[1734899812] 'agreement among raft nodes before linearized reading' (duration: 539.605407ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:39.546901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:39.006894Z","time spent":"539.987001ms","remote":"127.0.0.1:41166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5706,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-19T01:54:39.547168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.80614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-09-19T01:54:39.547303Z","caller":"traceutil/trace.go:171","msg":"trace[546304005] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2825; }","duration":"495.101023ms","start":"2026-09-19T01:54:39.052137Z","end":"2026-09-19T01:54:39.547238Z","steps":["trace[546304005] 'agreement among raft nodes before linearized reading' (duration: 494.581167ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:39.547425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:39.052111Z","time spent":"495.280464ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-09-19T01:54:39.547849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.586323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:54:39.547975Z","caller":"traceutil/trace.go:171","msg":"trace[1894630005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2825; }","duration":"332.676134ms","start":"2026-09-19T01:54:39.21525Z","end":"2026-09-19T01:54:39.547926Z","steps":["trace[1894630005] 'agreement among raft nodes before linearized reading' (duration: 332.564943ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:39.548069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:39.215183Z","time spent":"332.875045ms","remote":"127.0.0.1:45048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T01:54:45.370638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.327238ms","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-09-19T01:54:45.370769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.348277ms","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-09-19T01:54:45.370844Z","caller":"traceutil/trace.go:171","msg":"trace[1669721325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2853; }","duration":"380.476177ms","start":"2026-09-19T01:54:44.99035Z","end":"2026-09-19T01:54:45.370826Z","steps":["trace[1669721325] 'range keys from in-memory index tree' (duration: 380.136933ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:45.370885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:44.990327Z","time spent":"380.549579ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-19T01:54:45.370945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.246885ms","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-09-19T01:54:45.371052Z","caller":"traceutil/trace.go:171","msg":"trace[2034454191] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2853; }","duration":"142.397447ms","start":"2026-09-19T01:54:45.228632Z","end":"2026-09-19T01:54:45.37103Z","steps":["trace[2034454191] 'count revisions from in-memory index tree' (duration: 142.096263ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:54:45.370809Z","caller":"traceutil/trace.go:171","msg":"trace[14500515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2853; }","duration":"353.54413ms","start":"2026-09-19T01:54:45.017246Z","end":"2026-09-19T01:54:45.37079Z","steps":["trace[14500515] 'range keys from in-memory index tree' (duration: 353.168566ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:54:45.371224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:54:45.017229Z","time spent":"353.982224ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-19T01:54:45.371117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.310257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:54:45.371415Z","caller":"traceutil/trace.go:171","msg":"trace[1420806437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2853; }","duration":"292.666982ms","start":"2026-09-19T01:54:45.078724Z","end":"2026-09-19T01:54:45.371391Z","steps":["trace[1420806437] 'range keys from in-memory index tree' (duration: 291.972344ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:54:45.506215Z","caller":"traceutil/trace.go:171","msg":"trace[627202654] transaction","detail":"{read_only:false; response_revision:2854; number_of_response:1; }","duration":"130.543725ms","start":"2026-09-19T01:54:45.375642Z","end":"2026-09-19T01:54:45.506186Z","steps":["trace[627202654] 'process raft request' (duration: 130.419204ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:54:45.512853Z","caller":"traceutil/trace.go:171","msg":"trace[1440334342] transaction","detail":"{read_only:false; response_revision:2855; number_of_response:1; }","duration":"136.746025ms","start":"2026-09-19T01:54:45.376082Z","end":"2026-09-19T01:54:45.512828Z","steps":["trace[1440334342] 'process raft request' (duration: 136.588383ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:55:20.114688Z","caller":"traceutil/trace.go:171","msg":"trace[248455707] transaction","detail":"{read_only:false; response_revision:3038; number_of_response:1; }","duration":"103.274475ms","start":"2026-09-19T01:55:20.01138Z","end":"2026-09-19T01:55:20.114655Z","steps":["trace[248455707] 'process raft request' (duration: 103.067021ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:58:21.404197Z","caller":"traceutil/trace.go:171","msg":"trace[632563909] transaction","detail":"{read_only:false; response_revision:4109; number_of_response:1; }","duration":"107.617169ms","start":"2026-09-19T01:58:21.296551Z","end":"2026-09-19T01:58:21.404169Z","steps":["trace[632563909] 'process raft request' (duration: 107.381251ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:58:21.601074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.578278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/alertmanagers.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:58:21.601197Z","caller":"traceutil/trace.go:171","msg":"trace[480706720] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/alertmanagers.monitoring.coreos.com; range_end:; response_count:0; response_revision:4110; }","duration":"102.765485ms","start":"2026-09-19T01:58:21.498409Z","end":"2026-09-19T01:58:21.601175Z","steps":["trace[480706720] 'range keys from in-memory index tree' (duration: 102.509936ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:58:23.347611Z","caller":"traceutil/trace.go:171","msg":"trace[1745961572] transaction","detail":"{read_only:false; response_revision:4147; number_of_response:1; }","duration":"123.367659ms","start":"2026-09-19T01:58:23.22421Z","end":"2026-09-19T01:58:23.347577Z","steps":["trace[1745961572] 'process raft request' (duration: 50.158354ms)","trace[1745961572] 'compare' (duration: 73.022819ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:06.246439Z","caller":"traceutil/trace.go:171","msg":"trace[1213845585] transaction","detail":"{read_only:false; response_revision:4422; number_of_response:1; }","duration":"107.478122ms","start":"2026-09-19T01:59:06.138928Z","end":"2026-09-19T01:59:06.246406Z","steps":["trace[1213845585] 'process raft request' (duration: 23.020145ms)","trace[1213845585] 'compare' (duration: 84.27914ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:06.246471Z","caller":"traceutil/trace.go:171","msg":"trace[1040905619] transaction","detail":"{read_only:false; response_revision:4423; number_of_response:1; }","duration":"107.005496ms","start":"2026-09-19T01:59:06.139445Z","end":"2026-09-19T01:59:06.24645Z","steps":["trace[1040905619] 'process raft request' (duration: 106.911582ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.24645Z","caller":"traceutil/trace.go:171","msg":"trace[1986685175] linearizableReadLoop","detail":"{readStateIndex:4604; appliedIndex:4603; }","duration":"107.12122ms","start":"2026-09-19T01:59:06.139305Z","end":"2026-09-19T01:59:06.246427Z","steps":["trace[1986685175] 'read index received' (duration: 22.640372ms)","trace[1986685175] 'applied index is now lower than readState.Index' (duration: 84.478458ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:59:06.246689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.362768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-create-n2qmn\" ","response":"range_response_count:1 size:4595"} {"level":"info","ts":"2026-09-19T01:59:06.246733Z","caller":"traceutil/trace.go:171","msg":"trace[720995324] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-create-n2qmn; range_end:; response_count:1; response_revision:4424; }","duration":"107.480052ms","start":"2026-09-19T01:59:06.139239Z","end":"2026-09-19T01:59:06.246719Z","steps":["trace[720995324] 'agreement among raft nodes before linearized reading' (duration: 107.232093ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.246778Z","caller":"traceutil/trace.go:171","msg":"trace[1259232067] transaction","detail":"{read_only:false; response_revision:4424; number_of_response:1; }","duration":"107.13983ms","start":"2026-09-19T01:59:06.139589Z","end":"2026-09-19T01:59:06.246728Z","steps":["trace[1259232067] 'process raft request' (duration: 106.803039ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.247655Z","caller":"traceutil/trace.go:171","msg":"trace[101190268] transaction","detail":"{read_only:false; response_revision:4425; number_of_response:1; }","duration":"108.050382ms","start":"2026-09-19T01:59:06.139575Z","end":"2026-09-19T01:59:06.247625Z","steps":["trace[101190268] 'process raft request' (duration: 107.648548ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.247686Z","caller":"traceutil/trace.go:171","msg":"trace[1375998941] transaction","detail":"{read_only:false; response_revision:4427; number_of_response:1; }","duration":"106.554028ms","start":"2026-09-19T01:59:06.141108Z","end":"2026-09-19T01:59:06.247662Z","steps":["trace[1375998941] 'process raft request' (duration: 106.243747ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.247786Z","caller":"traceutil/trace.go:171","msg":"trace[1757565073] transaction","detail":"{read_only:false; response_revision:4426; number_of_response:1; }","duration":"107.792543ms","start":"2026-09-19T01:59:06.139986Z","end":"2026-09-19T01:59:06.247778Z","steps":["trace[1757565073] 'process raft request' (duration: 107.328476ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:06.47136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.646652ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:59:06.471647Z","caller":"traceutil/trace.go:171","msg":"trace[168373426] transaction","detail":"{read_only:false; response_revision:4434; number_of_response:1; }","duration":"135.756055ms","start":"2026-09-19T01:59:06.335865Z","end":"2026-09-19T01:59:06.471621Z","steps":["trace[168373426] 'process raft request' (duration: 135.635841ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.47166Z","caller":"traceutil/trace.go:171","msg":"trace[1865707055] transaction","detail":"{read_only:false; response_revision:4433; number_of_response:1; }","duration":"135.87569ms","start":"2026-09-19T01:59:06.335735Z","end":"2026-09-19T01:59:06.471611Z","steps":["trace[1865707055] 'process raft request' (duration: 28.922767ms)","trace[1865707055] 'compare' (duration: 106.541718ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:06.471826Z","caller":"traceutil/trace.go:171","msg":"trace[727971284] transaction","detail":"{read_only:false; response_revision:4437; number_of_response:1; }","duration":"132.278561ms","start":"2026-09-19T01:59:06.339542Z","end":"2026-09-19T01:59:06.47182Z","steps":["trace[727971284] 'process raft request' (duration: 132.065143ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.471817Z","caller":"traceutil/trace.go:171","msg":"trace[68572768] transaction","detail":"{read_only:false; response_revision:4436; number_of_response:1; }","duration":"133.037099ms","start":"2026-09-19T01:59:06.338723Z","end":"2026-09-19T01:59:06.471761Z","steps":["trace[68572768] 'process raft request' (duration: 132.863362ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.471931Z","caller":"traceutil/trace.go:171","msg":"trace[522049452] transaction","detail":"{read_only:false; response_revision:4440; number_of_response:1; }","duration":"129.575834ms","start":"2026-09-19T01:59:06.342347Z","end":"2026-09-19T01:59:06.471923Z","steps":["trace[522049452] 'process raft request' (duration: 129.368236ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.471997Z","caller":"traceutil/trace.go:171","msg":"trace[771049810] transaction","detail":"{read_only:false; response_revision:4441; number_of_response:1; }","duration":"129.658317ms","start":"2026-09-19T01:59:06.342333Z","end":"2026-09-19T01:59:06.471991Z","steps":["trace[771049810] 'process raft request' (duration: 129.415579ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.472042Z","caller":"traceutil/trace.go:171","msg":"trace[131272963] transaction","detail":"{read_only:false; response_revision:4442; number_of_response:1; }","duration":"129.610425ms","start":"2026-09-19T01:59:06.342416Z","end":"2026-09-19T01:59:06.472026Z","steps":["trace[131272963] 'process raft request' (duration: 129.416899ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.472062Z","caller":"traceutil/trace.go:171","msg":"trace[8513564] transaction","detail":"{read_only:false; response_revision:4443; number_of_response:1; }","duration":"129.562253ms","start":"2026-09-19T01:59:06.342494Z","end":"2026-09-19T01:59:06.472056Z","steps":["trace[8513564] 'process raft request' (duration: 129.392398ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.472119Z","caller":"traceutil/trace.go:171","msg":"trace[1454763227] transaction","detail":"{read_only:false; response_revision:4444; number_of_response:1; }","duration":"128.07141ms","start":"2026-09-19T01:59:06.34404Z","end":"2026-09-19T01:59:06.472112Z","steps":["trace[1454763227] 'process raft request' (duration: 127.936906ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.471766Z","caller":"traceutil/trace.go:171","msg":"trace[446886884] transaction","detail":"{read_only:false; response_revision:4435; number_of_response:1; }","duration":"135.157904ms","start":"2026-09-19T01:59:06.336601Z","end":"2026-09-19T01:59:06.471759Z","steps":["trace[446886884] 'process raft request' (duration: 134.957816ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.471989Z","caller":"traceutil/trace.go:171","msg":"trace[1612592236] transaction","detail":"{read_only:false; response_revision:4439; number_of_response:1; }","duration":"129.722429ms","start":"2026-09-19T01:59:06.342178Z","end":"2026-09-19T01:59:06.471901Z","steps":["trace[1612592236] 'process raft request' (duration: 129.474889ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.471794Z","caller":"traceutil/trace.go:171","msg":"trace[1152042235] transaction","detail":"{read_only:false; response_revision:4438; number_of_response:1; }","duration":"132.093084ms","start":"2026-09-19T01:59:06.339695Z","end":"2026-09-19T01:59:06.471788Z","steps":["trace[1152042235] 'process raft request' (duration: 131.928537ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.47228Z","caller":"traceutil/trace.go:171","msg":"trace[646798022] transaction","detail":"{read_only:false; response_revision:4445; number_of_response:1; }","duration":"128.112101ms","start":"2026-09-19T01:59:06.344136Z","end":"2026-09-19T01:59:06.472248Z","steps":["trace[646798022] 'process raft request' (duration: 127.914214ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.472353Z","caller":"traceutil/trace.go:171","msg":"trace[1128607464] transaction","detail":"{read_only:false; response_revision:4446; number_of_response:1; }","duration":"128.121472ms","start":"2026-09-19T01:59:06.344226Z","end":"2026-09-19T01:59:06.472348Z","steps":["trace[1128607464] 'process raft request' (duration: 127.893204ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.472611Z","caller":"traceutil/trace.go:171","msg":"trace[786682262] transaction","detail":"{read_only:false; response_revision:4451; number_of_response:1; }","duration":"128.10311ms","start":"2026-09-19T01:59:06.344494Z","end":"2026-09-19T01:59:06.472598Z","steps":["trace[786682262] 'process raft request' (duration: 127.935425ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.472739Z","caller":"traceutil/trace.go:171","msg":"trace[1843055774] transaction","detail":"{read_only:false; response_revision:4454; number_of_response:1; }","duration":"126.828785ms","start":"2026-09-19T01:59:06.345833Z","end":"2026-09-19T01:59:06.472661Z","steps":["trace[1843055774] 'process raft request' (duration: 126.68674ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.472942Z","caller":"traceutil/trace.go:171","msg":"trace[1766663427] transaction","detail":"{read_only:false; response_revision:4463; number_of_response:1; }","duration":"119.431859ms","start":"2026-09-19T01:59:06.353499Z","end":"2026-09-19T01:59:06.472931Z","steps":["trace[1766663427] 'process raft request' (duration: 119.404278ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.47307Z","caller":"traceutil/trace.go:171","msg":"trace[1269295562] transaction","detail":"{read_only:false; response_revision:4452; number_of_response:1; }","duration":"127.336064ms","start":"2026-09-19T01:59:06.34572Z","end":"2026-09-19T01:59:06.473056Z","steps":["trace[1269295562] 'process raft request' (duration: 126.734342ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473098Z","caller":"traceutil/trace.go:171","msg":"trace[848823333] transaction","detail":"{read_only:false; response_revision:4453; number_of_response:1; }","duration":"127.26585ms","start":"2026-09-19T01:59:06.345823Z","end":"2026-09-19T01:59:06.473088Z","steps":["trace[848823333] 'process raft request' (duration: 126.648998ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473175Z","caller":"traceutil/trace.go:171","msg":"trace[1673746659] transaction","detail":"{read_only:false; response_revision:4462; number_of_response:1; }","duration":"120.251059ms","start":"2026-09-19T01:59:06.352917Z","end":"2026-09-19T01:59:06.473168Z","steps":["trace[1673746659] 'process raft request' (duration: 119.921857ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473265Z","caller":"traceutil/trace.go:171","msg":"trace[224475602] transaction","detail":"{read_only:false; response_revision:4460; number_of_response:1; }","duration":"120.766059ms","start":"2026-09-19T01:59:06.352491Z","end":"2026-09-19T01:59:06.473257Z","steps":["trace[224475602] 'process raft request' (duration: 120.279401ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473356Z","caller":"traceutil/trace.go:171","msg":"trace[1883049227] transaction","detail":"{read_only:false; response_revision:4455; number_of_response:1; }","duration":"127.345964ms","start":"2026-09-19T01:59:06.346004Z","end":"2026-09-19T01:59:06.47335Z","steps":["trace[1883049227] 'process raft request' (duration: 126.539365ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473403Z","caller":"traceutil/trace.go:171","msg":"trace[318618476] transaction","detail":"{read_only:false; response_revision:4457; number_of_response:1; }","duration":"123.846179ms","start":"2026-09-19T01:59:06.349552Z","end":"2026-09-19T01:59:06.473398Z","steps":["trace[318618476] 'process raft request' (duration: 123.034869ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473491Z","caller":"traceutil/trace.go:171","msg":"trace[449205450] transaction","detail":"{read_only:false; response_revision:4459; number_of_response:1; }","duration":"121.051109ms","start":"2026-09-19T01:59:06.352417Z","end":"2026-09-19T01:59:06.473468Z","steps":["trace[449205450] 'process raft request' (duration: 120.25492ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473289Z","caller":"traceutil/trace.go:171","msg":"trace[1717590972] transaction","detail":"{read_only:false; response_revision:4461; number_of_response:1; }","duration":"120.739887ms","start":"2026-09-19T01:59:06.352542Z","end":"2026-09-19T01:59:06.473282Z","steps":["trace[1717590972] 'process raft request' (duration: 120.252559ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473387Z","caller":"traceutil/trace.go:171","msg":"trace[347077347] transaction","detail":"{read_only:false; response_revision:4456; number_of_response:1; }","duration":"127.332823ms","start":"2026-09-19T01:59:06.346049Z","end":"2026-09-19T01:59:06.473382Z","steps":["trace[347077347] 'process raft request' (duration: 126.516043ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473365Z","caller":"traceutil/trace.go:171","msg":"trace[785059011] transaction","detail":"{read_only:false; response_revision:4458; number_of_response:1; }","duration":"121.080079ms","start":"2026-09-19T01:59:06.35228Z","end":"2026-09-19T01:59:06.47336Z","steps":["trace[785059011] 'process raft request' (duration: 120.331242ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473705Z","caller":"traceutil/trace.go:171","msg":"trace[1709916333] transaction","detail":"{read_only:false; response_revision:4448; number_of_response:1; }","duration":"129.383037ms","start":"2026-09-19T01:59:06.344305Z","end":"2026-09-19T01:59:06.473688Z","steps":["trace[1709916333] 'process raft request' (duration: 127.961336ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473722Z","caller":"traceutil/trace.go:171","msg":"trace[1614611397] transaction","detail":"{read_only:false; response_revision:4449; number_of_response:1; }","duration":"129.373476ms","start":"2026-09-19T01:59:06.344336Z","end":"2026-09-19T01:59:06.47371Z","steps":["trace[1614611397] 'process raft request' (duration: 127.991716ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473826Z","caller":"traceutil/trace.go:171","msg":"trace[1379895002] transaction","detail":"{read_only:false; response_revision:4447; number_of_response:1; }","duration":"129.519122ms","start":"2026-09-19T01:59:06.344277Z","end":"2026-09-19T01:59:06.473797Z","steps":["trace[1379895002] 'process raft request' (duration: 127.941795ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.473983Z","caller":"traceutil/trace.go:171","msg":"trace[484936955] transaction","detail":"{read_only:false; response_revision:4450; number_of_response:1; }","duration":"129.510181ms","start":"2026-09-19T01:59:06.344463Z","end":"2026-09-19T01:59:06.473973Z","steps":["trace[484936955] 'process raft request' (duration: 127.891543ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.608368Z","caller":"traceutil/trace.go:171","msg":"trace[1344392590] transaction","detail":"{read_only:false; response_revision:4467; number_of_response:1; }","duration":"113.481127ms","start":"2026-09-19T01:59:06.494857Z","end":"2026-09-19T01:59:06.608338Z","steps":["trace[1344392590] 'process raft request' (duration: 113.434025ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:06.608397Z","caller":"traceutil/trace.go:171","msg":"trace[1364369676] transaction","detail":"{read_only:false; response_revision:4465; number_of_response:1; }","duration":"116.613228ms","start":"2026-09-19T01:59:06.491761Z","end":"2026-09-19T01:59:06.608374Z","steps":["trace[1364369676] 'process raft request' (duration: 90.412059ms)","trace[1364369676] 'compare' (duration: 25.952971ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:06.608436Z","caller":"traceutil/trace.go:171","msg":"trace[1489058692] transaction","detail":"{read_only:false; response_revision:4466; number_of_response:1; }","duration":"116.469704ms","start":"2026-09-19T01:59:06.491944Z","end":"2026-09-19T01:59:06.608414Z","steps":["trace[1489058692] 'process raft request' (duration: 116.296248ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:09.413757Z","caller":"traceutil/trace.go:171","msg":"trace[1141659826] linearizableReadLoop","detail":"{readStateIndex:4945; appliedIndex:4944; }","duration":"139.16455ms","start":"2026-09-19T01:59:09.274568Z","end":"2026-09-19T01:59:09.413732Z","steps":["trace[1141659826] 'read index received' (duration: 137.608254ms)","trace[1141659826] 'applied index is now lower than readState.Index' (duration: 1.554916ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:09.41391Z","caller":"traceutil/trace.go:171","msg":"trace[971837438] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"151.913617ms","start":"2026-09-19T01:59:09.261916Z","end":"2026-09-19T01:59:09.413829Z","steps":["trace[971837438] 'process raft request' (duration: 150.277238ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:09.414367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.879678ms","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-09-19T01:59:09.414418Z","caller":"traceutil/trace.go:171","msg":"trace[393609358] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4757; }","duration":"148.94196ms","start":"2026-09-19T01:59:09.265462Z","end":"2026-09-19T01:59:09.414404Z","steps":["trace[393609358] 'agreement among raft nodes before linearized reading' (duration: 148.433382ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:09.414803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.398282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1896"} {"level":"info","ts":"2026-09-19T01:59:09.415209Z","caller":"traceutil/trace.go:171","msg":"trace[1150108822] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4757; }","duration":"133.59892ms","start":"2026-09-19T01:59:09.281301Z","end":"2026-09-19T01:59:09.4149Z","steps":["trace[1150108822] 'agreement among raft nodes before linearized reading' (duration: 132.656896ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:13.692741Z","caller":"traceutil/trace.go:171","msg":"trace[483215478] linearizableReadLoop","detail":"{readStateIndex:4998; appliedIndex:4997; }","duration":"246.803122ms","start":"2026-09-19T01:59:13.445924Z","end":"2026-09-19T01:59:13.692727Z","steps":["trace[483215478] 'read index received' (duration: 246.72409ms)","trace[483215478] 'applied index is now lower than readState.Index' (duration: 78.422µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:13.692785Z","caller":"traceutil/trace.go:171","msg":"trace[2018633154] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"248.08122ms","start":"2026-09-19T01:59:13.444678Z","end":"2026-09-19T01:59:13.692759Z","steps":["trace[2018633154] 'process raft request' (duration: 247.955765ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:13.692961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.034292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-19T01:59:13.693036Z","caller":"traceutil/trace.go:171","msg":"trace[1494639] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4808; }","duration":"247.158087ms","start":"2026-09-19T01:59:13.445859Z","end":"2026-09-19T01:59:13.693017Z","steps":["trace[1494639] 'agreement among raft nodes before linearized reading' (duration: 246.940299ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:14.109418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.296923ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:59:14.109899Z","caller":"traceutil/trace.go:171","msg":"trace[7854880] transaction","detail":"{read_only:false; response_revision:4809; number_of_response:1; }","duration":"503.684062ms","start":"2026-09-19T01:59:13.606194Z","end":"2026-09-19T01:59:14.109878Z","steps":["trace[7854880] 'process raft request' (duration: 376.831738ms)","trace[7854880] 'compare' (duration: 126.18469ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:59:14.110009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:13.606171Z","time spent":"503.796026ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:59:14.110163Z","caller":"traceutil/trace.go:171","msg":"trace[1891244216] linearizableReadLoop","detail":"{readStateIndex:4999; appliedIndex:4998; }","duration":"417.370672ms","start":"2026-09-19T01:59:13.692781Z","end":"2026-09-19T01:59:14.110152Z","steps":["trace[1891244216] 'read index received' (duration: 290.256359ms)","trace[1891244216] 'applied index is now lower than readState.Index' (duration: 127.112993ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:14.110234Z","caller":"traceutil/trace.go:171","msg":"trace[882894921] transaction","detail":"{read_only:false; response_revision:4810; number_of_response:1; }","duration":"413.293135ms","start":"2026-09-19T01:59:13.696932Z","end":"2026-09-19T01:59:14.110225Z","steps":["trace[882894921] 'process raft request' (duration: 412.576188ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:14.110291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:13.696889Z","time spent":"413.369898ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:59:14.110554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.494172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:59:14.110595Z","caller":"traceutil/trace.go:171","msg":"trace[2119747055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4811; }","duration":"549.546653ms","start":"2026-09-19T01:59:13.561038Z","end":"2026-09-19T01:59:14.110585Z","steps":["trace[2119747055] 'agreement among raft nodes before linearized reading' (duration: 549.480671ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:14.110624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:13.561032Z","time spent":"549.585245ms","remote":"127.0.0.1:45048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T01:59:14.111302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.546654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:15 size:490899"} {"level":"info","ts":"2026-09-19T01:59:14.111352Z","caller":"traceutil/trace.go:171","msg":"trace[1201669145] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:15; response_revision:4811; }","duration":"564.629808ms","start":"2026-09-19T01:59:13.546711Z","end":"2026-09-19T01:59:14.111341Z","steps":["trace[1201669145] 'agreement among raft nodes before linearized reading' (duration: 564.025846ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:14.111383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:13.546694Z","time spent":"564.67776ms","remote":"127.0.0.1:45154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":15,"response size":490922,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"warn","ts":"2026-09-19T01:59:14.111888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.235018ms","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-09-19T01:59:14.111945Z","caller":"traceutil/trace.go:171","msg":"trace[1829153292] 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:4811; }","duration":"631.330071ms","start":"2026-09-19T01:59:13.480606Z","end":"2026-09-19T01:59:14.111936Z","steps":["trace[1829153292] 'agreement among raft nodes before linearized reading' (duration: 631.253088ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:14.111972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:13.480586Z","time spent":"631.378073ms","remote":"127.0.0.1:47156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-09-19T01:59:14.112174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.870377ms","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-09-19T01:59:14.11223Z","caller":"traceutil/trace.go:171","msg":"trace[1668927438] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4811; }","duration":"662.96251ms","start":"2026-09-19T01:59:13.449256Z","end":"2026-09-19T01:59:14.112219Z","steps":["trace[1668927438] 'agreement among raft nodes before linearized reading' (duration: 662.829545ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:14.112258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:13.449226Z","time spent":"663.023543ms","remote":"127.0.0.1:45342","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-09-19T01:59:14.112457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.028428ms","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-09-19T01:59:14.112491Z","caller":"traceutil/trace.go:171","msg":"trace[418199136] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4811; }","duration":"289.09645ms","start":"2026-09-19T01:59:13.823387Z","end":"2026-09-19T01:59:14.112483Z","steps":["trace[418199136] 'agreement among raft nodes before linearized reading' (duration: 289.006846ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:14.113011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.226396ms","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-09-19T01:59:14.113055Z","caller":"traceutil/trace.go:171","msg":"trace[666270904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4811; }","duration":"140.307588ms","start":"2026-09-19T01:59:13.972736Z","end":"2026-09-19T01:59:14.113043Z","steps":["trace[666270904] 'agreement among raft nodes before linearized reading' (duration: 140.213115ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:14.113697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.056952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:59:14.115884Z","caller":"traceutil/trace.go:171","msg":"trace[1840666934] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4811; }","duration":"174.22776ms","start":"2026-09-19T01:59:13.941607Z","end":"2026-09-19T01:59:14.115834Z","steps":["trace[1840666934] 'agreement among raft nodes before linearized reading' (duration: 172.038251ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:14.114134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.621313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:59:14.11605Z","caller":"traceutil/trace.go:171","msg":"trace[1650699351] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:4811; }","duration":"174.555163ms","start":"2026-09-19T01:59:13.941464Z","end":"2026-09-19T01:59:14.116019Z","steps":["trace[1650699351] 'agreement among raft nodes before linearized reading' (duration: 172.621553ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:15.202869Z","caller":"traceutil/trace.go:171","msg":"trace[181784794] linearizableReadLoop","detail":"{readStateIndex:5014; appliedIndex:5012; }","duration":"126.510855ms","start":"2026-09-19T01:59:15.076332Z","end":"2026-09-19T01:59:15.202842Z","steps":["trace[181784794] 'read index received' (duration: 28.835501ms)","trace[181784794] 'applied index is now lower than readState.Index' (duration: 97.674614ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:15.203035Z","caller":"traceutil/trace.go:171","msg":"trace[1336742114] transaction","detail":"{read_only:false; response_revision:4822; number_of_response:1; }","duration":"144.257816ms","start":"2026-09-19T01:59:15.058766Z","end":"2026-09-19T01:59:15.203024Z","steps":["trace[1336742114] 'process raft request' (duration: 141.905941ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:15.20327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.919251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:59:15.203323Z","caller":"traceutil/trace.go:171","msg":"trace[1477297712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4823; }","duration":"127.016304ms","start":"2026-09-19T01:59:15.076294Z","end":"2026-09-19T01:59:15.203311Z","steps":["trace[1477297712] 'agreement among raft nodes before linearized reading' (duration: 126.91072ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:15.203371Z","caller":"traceutil/trace.go:171","msg":"trace[1479398953] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"144.036258ms","start":"2026-09-19T01:59:15.059328Z","end":"2026-09-19T01:59:15.203364Z","steps":["trace[1479398953] 'process raft request' (duration: 143.470317ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:15.822486Z","caller":"traceutil/trace.go:171","msg":"trace[477347094] linearizableReadLoop","detail":"{readStateIndex:5048; appliedIndex:5047; }","duration":"126.036459ms","start":"2026-09-19T01:59:15.696427Z","end":"2026-09-19T01:59:15.822463Z","steps":["trace[477347094] 'read index received' (duration: 125.853202ms)","trace[477347094] 'applied index is now lower than readState.Index' (duration: 182.537µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:15.822737Z","caller":"traceutil/trace.go:171","msg":"trace[1605567802] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"155.828893ms","start":"2026-09-19T01:59:15.666892Z","end":"2026-09-19T01:59:15.822721Z","steps":["trace[1605567802] 'process raft request' (duration: 155.448779ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:15.823203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.746304ms","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-09-19T01:59:15.823293Z","caller":"traceutil/trace.go:171","msg":"trace[1514780057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4857; }","duration":"126.874168ms","start":"2026-09-19T01:59:15.696397Z","end":"2026-09-19T01:59:15.823271Z","steps":["trace[1514780057] 'agreement among raft nodes before linearized reading' (duration: 126.523446ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:17.476885Z","caller":"traceutil/trace.go:171","msg":"trace[948324287] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"156.692373ms","start":"2026-09-19T01:59:17.320153Z","end":"2026-09-19T01:59:17.476845Z","steps":["trace[948324287] 'process raft request' (duration: 112.935762ms)","trace[948324287] 'compare' (duration: 43.598486ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:17.528597Z","caller":"traceutil/trace.go:171","msg":"trace[1867780524] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"179.938013ms","start":"2026-09-19T01:59:17.348627Z","end":"2026-09-19T01:59:17.528566Z","steps":["trace[1867780524] 'process raft request' (duration: 179.780347ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:19.318821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.156793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-19T01:59:19.318964Z","caller":"traceutil/trace.go:171","msg":"trace[1540062870] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4947; }","duration":"132.34251ms","start":"2026-09-19T01:59:19.186604Z","end":"2026-09-19T01:59:19.318946Z","steps":["trace[1540062870] 'range keys from in-memory index tree' (duration: 131.338342ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:20.475552Z","caller":"traceutil/trace.go:171","msg":"trace[2083781990] linearizableReadLoop","detail":"{readStateIndex:5151; appliedIndex:5150; }","duration":"398.726932ms","start":"2026-09-19T01:59:20.076799Z","end":"2026-09-19T01:59:20.475526Z","steps":["trace[2083781990] 'read index received' (duration: 398.140361ms)","trace[2083781990] 'applied index is now lower than readState.Index' (duration: 585.551µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:20.475576Z","caller":"traceutil/trace.go:171","msg":"trace[1363661835] transaction","detail":"{read_only:false; response_revision:4955; number_of_response:1; }","duration":"516.709583ms","start":"2026-09-19T01:59:19.958839Z","end":"2026-09-19T01:59:20.475549Z","steps":["trace[1363661835] 'process raft request' (duration: 516.091811ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.475764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:19.95882Z","time spent":"516.865028ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:59:20.475852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.019122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-9xc99\" ","response":"range_response_count:1 size:9757"} {"level":"info","ts":"2026-09-19T01:59:20.475936Z","caller":"traceutil/trace.go:171","msg":"trace[922160928] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-9xc99; range_end:; response_count:1; response_revision:4955; }","duration":"399.157927ms","start":"2026-09-19T01:59:20.076757Z","end":"2026-09-19T01:59:20.475915Z","steps":["trace[922160928] 'agreement among raft nodes before linearized reading' (duration: 398.864516ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.475979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.076736Z","time spent":"399.23383ms","remote":"127.0.0.1:45264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9780,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-9xc99\" "} {"level":"info","ts":"2026-09-19T01:59:20.500952Z","caller":"traceutil/trace.go:171","msg":"trace[572453113] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"423.364873ms","start":"2026-09-19T01:59:20.077551Z","end":"2026-09-19T01:59:20.500916Z","steps":["trace[572453113] 'process raft request' (duration: 423.144605ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.501222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.077536Z","time spent":"423.532009ms","remote":"127.0.0.1:45134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:59:20.501319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.238384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:59:20.501396Z","caller":"traceutil/trace.go:171","msg":"trace[2127248288] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4958; }","duration":"424.323359ms","start":"2026-09-19T01:59:20.077044Z","end":"2026-09-19T01:59:20.501367Z","steps":["trace[2127248288] 'agreement among raft nodes before linearized reading' (duration: 424.225445ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:20.50139Z","caller":"traceutil/trace.go:171","msg":"trace[590843853] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"369.370867ms","start":"2026-09-19T01:59:20.131923Z","end":"2026-09-19T01:59:20.501294Z","steps":["trace[590843853] 'process raft request' (duration: 368.927701ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:20.501442Z","caller":"traceutil/trace.go:171","msg":"trace[1810905919] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"366.953552ms","start":"2026-09-19T01:59:20.134424Z","end":"2026-09-19T01:59:20.501378Z","steps":["trace[1810905919] 'process raft request' (duration: 366.508885ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.501448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.077001Z","time spent":"424.432623ms","remote":"127.0.0.1:41132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-09-19T01:59:20.501462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.917424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-19T01:59:20.501501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.131899Z","time spent":"369.534384ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:59:20.501548Z","caller":"traceutil/trace.go:171","msg":"trace[1821300368] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:4958; }","duration":"273.048769ms","start":"2026-09-19T01:59:20.228479Z","end":"2026-09-19T01:59:20.501528Z","steps":["trace[1821300368] 'agreement among raft nodes before linearized reading' (duration: 272.908914ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.501577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.134401Z","time spent":"367.104796ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:59:20.501208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.329981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:59:20.501716Z","caller":"traceutil/trace.go:171","msg":"trace[1090324625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4958; }","duration":"423.872672ms","start":"2026-09-19T01:59:20.077828Z","end":"2026-09-19T01:59:20.5017Z","steps":["trace[1090324625] 'agreement among raft nodes before linearized reading' (duration: 423.309801ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.501757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.07782Z","time spent":"423.925834ms","remote":"127.0.0.1:45048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T01:59:20.501945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.595361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4c66dcc0-db58-4267-87ff-3595530bf503\" ","response":"range_response_count:1 size:4053"} {"level":"warn","ts":"2026-09-19T01:59:20.502056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.830019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-09-19T01:59:20.502075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.40212ms","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-09-19T01:59:20.502103Z","caller":"traceutil/trace.go:171","msg":"trace[833166518] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4c66dcc0-db58-4267-87ff-3595530bf503; range_end:; response_count:1; response_revision:4958; }","duration":"386.656274ms","start":"2026-09-19T01:59:20.115309Z","end":"2026-09-19T01:59:20.501965Z","steps":["trace[833166518] 'agreement among raft nodes before linearized reading' (duration: 385.919646ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:20.502111Z","caller":"traceutil/trace.go:171","msg":"trace[1011778151] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4958; }","duration":"324.484962ms","start":"2026-09-19T01:59:20.177615Z","end":"2026-09-19T01:59:20.5021Z","steps":["trace[1011778151] 'agreement among raft nodes before linearized reading' (duration: 324.074678ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.502138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.177586Z","time spent":"324.544454ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-19T01:59:20.502126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.11529Z","time spent":"386.83031ms","remote":"127.0.0.1:45264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":4076,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4c66dcc0-db58-4267-87ff-3595530bf503\" "} {"level":"info","ts":"2026-09-19T01:59:20.502223Z","caller":"traceutil/trace.go:171","msg":"trace[480530913] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4958; }","duration":"339.88575ms","start":"2026-09-19T01:59:20.162185Z","end":"2026-09-19T01:59:20.502071Z","steps":["trace[480530913] 'agreement among raft nodes before linearized reading' (duration: 339.07335ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.502226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.668089ms","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-09-19T01:59:20.502226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.683146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-19T01:59:20.502277Z","caller":"traceutil/trace.go:171","msg":"trace[955277926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4958; }","duration":"324.783673ms","start":"2026-09-19T01:59:20.177479Z","end":"2026-09-19T01:59:20.502263Z","steps":["trace[955277926] 'agreement among raft nodes before linearized reading' (duration: 323.59935ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.502342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.177461Z","time spent":"324.868836ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-19T01:59:20.50238Z","caller":"traceutil/trace.go:171","msg":"trace[1572608956] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4958; }","duration":"367.776999ms","start":"2026-09-19T01:59:20.134495Z","end":"2026-09-19T01:59:20.502272Z","steps":["trace[1572608956] 'agreement among raft nodes before linearized reading' (duration: 366.776323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.502435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.134463Z","time spent":"367.955287ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-09-19T01:59:20.502248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:20.162166Z","time spent":"340.074657ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-19T01:59:20.68121Z","caller":"traceutil/trace.go:171","msg":"trace[1522508404] linearizableReadLoop","detail":"{readStateIndex:5155; appliedIndex:5154; }","duration":"180.212337ms","start":"2026-09-19T01:59:20.500967Z","end":"2026-09-19T01:59:20.68118Z","steps":["trace[1522508404] 'read index received' (duration: 179.997279ms)","trace[1522508404] 'applied index is now lower than readState.Index' (duration: 213.618µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:20.681317Z","caller":"traceutil/trace.go:171","msg":"trace[2054428045] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"191.533047ms","start":"2026-09-19T01:59:20.489743Z","end":"2026-09-19T01:59:20.681276Z","steps":["trace[2054428045] 'process raft request' (duration: 191.200086ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.681401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.883619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:59:20.681443Z","caller":"traceutil/trace.go:171","msg":"trace[1337731849] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:4959; }","duration":"183.993263ms","start":"2026-09-19T01:59:20.497439Z","end":"2026-09-19T01:59:20.681432Z","steps":["trace[1337731849] 'agreement among raft nodes before linearized reading' (duration: 183.885209ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:20.708264Z","caller":"traceutil/trace.go:171","msg":"trace[2015207552] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"199.555697ms","start":"2026-09-19T01:59:20.508678Z","end":"2026-09-19T01:59:20.708233Z","steps":["trace[2015207552] 'process raft request' (duration: 199.348299ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:20.70876Z","caller":"traceutil/trace.go:171","msg":"trace[1041983481] transaction","detail":"{read_only:false; response_revision:4961; number_of_response:1; }","duration":"199.995224ms","start":"2026-09-19T01:59:20.508723Z","end":"2026-09-19T01:59:20.708718Z","steps":["trace[1041983481] 'process raft request' (duration: 199.421242ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:20.70891Z","caller":"traceutil/trace.go:171","msg":"trace[954428070] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"194.10923ms","start":"2026-09-19T01:59:20.51477Z","end":"2026-09-19T01:59:20.708879Z","steps":["trace[954428070] 'process raft request' (duration: 193.962545ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:20.709307Z","caller":"traceutil/trace.go:171","msg":"trace[144351327] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"197.119039ms","start":"2026-09-19T01:59:20.512169Z","end":"2026-09-19T01:59:20.709288Z","steps":["trace[144351327] 'process raft request' (duration: 196.514408ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:20.709384Z","caller":"traceutil/trace.go:171","msg":"trace[300446685] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"197.552285ms","start":"2026-09-19T01:59:20.511813Z","end":"2026-09-19T01:59:20.709365Z","steps":["trace[300446685] 'process raft request' (duration: 196.702894ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:20.709448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.712496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cded818b-f0a9-4f7a-ba34-43221a7c71bd\" ","response":"range_response_count:1 size:4080"} {"level":"warn","ts":"2026-09-19T01:59:20.709309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.562868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:59:20.709519Z","caller":"traceutil/trace.go:171","msg":"trace[864834902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4964; }","duration":"204.827718ms","start":"2026-09-19T01:59:20.504684Z","end":"2026-09-19T01:59:20.709511Z","steps":["trace[864834902] 'agreement among raft nodes before linearized reading' (duration: 204.531797ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:20.709524Z","caller":"traceutil/trace.go:171","msg":"trace[1629898441] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cded818b-f0a9-4f7a-ba34-43221a7c71bd; range_end:; response_count:1; response_revision:4964; }","duration":"127.83929ms","start":"2026-09-19T01:59:20.581663Z","end":"2026-09-19T01:59:20.709503Z","steps":["trace[1629898441] 'agreement among raft nodes before linearized reading' (duration: 127.604771ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:22.627126Z","caller":"traceutil/trace.go:171","msg":"trace[2044094286] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"105.06302ms","start":"2026-09-19T01:59:22.522046Z","end":"2026-09-19T01:59:22.627109Z","steps":["trace[2044094286] 'process raft request' (duration: 104.739599ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:22.627297Z","caller":"traceutil/trace.go:171","msg":"trace[1429280474] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"105.135943ms","start":"2026-09-19T01:59:22.522154Z","end":"2026-09-19T01:59:22.62729Z","steps":["trace[1429280474] 'process raft request' (duration: 104.719918ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:22.627572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.238278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11455"} {"level":"info","ts":"2026-09-19T01:59:22.627595Z","caller":"traceutil/trace.go:171","msg":"trace[101035371] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4995; }","duration":"102.30595ms","start":"2026-09-19T01:59:22.525282Z","end":"2026-09-19T01:59:22.627588Z","steps":["trace[101035371] 'agreement among raft nodes before linearized reading' (duration: 102.204917ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:22.909437Z","caller":"traceutil/trace.go:171","msg":"trace[10519495] linearizableReadLoop","detail":"{readStateIndex:5195; appliedIndex:5194; }","duration":"195.655266ms","start":"2026-09-19T01:59:22.713755Z","end":"2026-09-19T01:59:22.909411Z","steps":["trace[10519495] 'read index received' (duration: 179.033814ms)","trace[10519495] 'applied index is now lower than readState.Index' (duration: 16.620282ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:22.909624Z","caller":"traceutil/trace.go:171","msg":"trace[621577317] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"267.129828ms","start":"2026-09-19T01:59:22.642446Z","end":"2026-09-19T01:59:22.909576Z","steps":["trace[621577317] 'process raft request' (duration: 250.36003ms)","trace[621577317] 'compare' (duration: 16.484207ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:59:22.909858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.078391ms","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-09-19T01:59:22.910114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.257323ms","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-09-19T01:59:22.910102Z","caller":"traceutil/trace.go:171","msg":"trace[1999423425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4997; }","duration":"196.371362ms","start":"2026-09-19T01:59:22.713702Z","end":"2026-09-19T01:59:22.910073Z","steps":["trace[1999423425] 'agreement among raft nodes before linearized reading' (duration: 195.986119ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:22.910155Z","caller":"traceutil/trace.go:171","msg":"trace[310334208] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4997; }","duration":"195.371337ms","start":"2026-09-19T01:59:22.714771Z","end":"2026-09-19T01:59:22.910143Z","steps":["trace[310334208] 'agreement among raft nodes before linearized reading' (duration: 195.18791ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:22.910163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.429996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-09-19T01:59:22.910245Z","caller":"traceutil/trace.go:171","msg":"trace[2103467824] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4997; }","duration":"166.555801ms","start":"2026-09-19T01:59:22.74367Z","end":"2026-09-19T01:59:22.910226Z","steps":["trace[2103467824] 'agreement among raft nodes before linearized reading' (duration: 166.293361ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:22.910383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.24073ms","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-09-19T01:59:22.910449Z","caller":"traceutil/trace.go:171","msg":"trace[1393348628] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4997; }","duration":"195.354735ms","start":"2026-09-19T01:59:22.71508Z","end":"2026-09-19T01:59:22.910435Z","steps":["trace[1393348628] 'agreement among raft nodes before linearized reading' (duration: 194.902039ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:22.910472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.898108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-19T01:59:22.910522Z","caller":"traceutil/trace.go:171","msg":"trace[1387718077] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4997; }","duration":"194.982172ms","start":"2026-09-19T01:59:22.715526Z","end":"2026-09-19T01:59:22.910508Z","steps":["trace[1387718077] 'agreement among raft nodes before linearized reading' (duration: 194.463513ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:23.123532Z","caller":"traceutil/trace.go:171","msg":"trace[1169473589] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"206.329636ms","start":"2026-09-19T01:59:22.917168Z","end":"2026-09-19T01:59:23.123497Z","steps":["trace[1169473589] 'process raft request' (duration: 188.034711ms)","trace[1169473589] 'compare' (duration: 18.021355ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:23.123855Z","caller":"traceutil/trace.go:171","msg":"trace[231895127] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"206.475652ms","start":"2026-09-19T01:59:22.917345Z","end":"2026-09-19T01:59:23.12382Z","steps":["trace[231895127] 'process raft request' (duration: 206.013435ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:23.124072Z","caller":"traceutil/trace.go:171","msg":"trace[1436080121] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"204.233481ms","start":"2026-09-19T01:59:22.919828Z","end":"2026-09-19T01:59:23.124061Z","steps":["trace[1436080121] 'process raft request' (duration: 203.577266ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:23.124155Z","caller":"traceutil/trace.go:171","msg":"trace[1151718534] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"133.364651ms","start":"2026-09-19T01:59:22.990782Z","end":"2026-09-19T01:59:23.124147Z","steps":["trace[1151718534] 'process raft request' (duration: 132.704596ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:25.479215Z","caller":"traceutil/trace.go:171","msg":"trace[1028881640] linearizableReadLoop","detail":"{readStateIndex:5270; appliedIndex:5269; }","duration":"472.998981ms","start":"2026-09-19T01:59:25.006168Z","end":"2026-09-19T01:59:25.479167Z","steps":["trace[1028881640] 'read index received' (duration: 472.732311ms)","trace[1028881640] 'applied index is now lower than readState.Index' (duration: 265.79µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:25.479268Z","caller":"traceutil/trace.go:171","msg":"trace[1443300142] transaction","detail":"{read_only:false; response_revision:5071; number_of_response:1; }","duration":"509.095412ms","start":"2026-09-19T01:59:24.970149Z","end":"2026-09-19T01:59:25.479244Z","steps":["trace[1443300142] 'process raft request' (duration: 508.835513ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.479417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:24.970132Z","time spent":"509.186205ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:59:25.479615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.301922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ba237ffa-7182-40ae-a648-482c9e4fc288\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-19T01:59:25.479671Z","caller":"traceutil/trace.go:171","msg":"trace[187063188] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ba237ffa-7182-40ae-a648-482c9e4fc288; range_end:; response_count:1; response_revision:5071; }","duration":"473.53632ms","start":"2026-09-19T01:59:25.006121Z","end":"2026-09-19T01:59:25.479657Z","steps":["trace[187063188] 'agreement among raft nodes before linearized reading' (duration: 473.200938ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.479705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:25.006104Z","time spent":"473.590952ms","remote":"127.0.0.1:45264","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-ba237ffa-7182-40ae-a648-482c9e4fc288\" "} {"level":"info","ts":"2026-09-19T01:59:25.740831Z","caller":"traceutil/trace.go:171","msg":"trace[617261274] linearizableReadLoop","detail":"{readStateIndex:5272; appliedIndex:5270; }","duration":"261.511995ms","start":"2026-09-19T01:59:25.479296Z","end":"2026-09-19T01:59:25.740808Z","steps":["trace[617261274] 'read index received' (duration: 261.262015ms)","trace[617261274] 'applied index is now lower than readState.Index' (duration: 249.36µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:59:25.741334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.86138ms","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-09-19T01:59:25.74139Z","caller":"traceutil/trace.go:171","msg":"trace[1723222642] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5073; }","duration":"613.961324ms","start":"2026-09-19T01:59:25.12741Z","end":"2026-09-19T01:59:25.741371Z","steps":["trace[1723222642] 'agreement among raft nodes before linearized reading' (duration: 613.797698ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.741393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.784082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-09-19T01:59:25.741435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:25.127389Z","time spent":"614.033817ms","remote":"127.0.0.1:45342","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":"info","ts":"2026-09-19T01:59:25.741478Z","caller":"traceutil/trace.go:171","msg":"trace[1022904761] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5073; }","duration":"612.921376ms","start":"2026-09-19T01:59:25.128535Z","end":"2026-09-19T01:59:25.741457Z","steps":["trace[1022904761] 'agreement among raft nodes before linearized reading' (duration: 612.646406ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.741517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:25.128527Z","time spent":"612.983419ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-09-19T01:59:25.741624Z","caller":"traceutil/trace.go:171","msg":"trace[1570632645] transaction","detail":"{read_only:false; response_revision:5072; number_of_response:1; }","duration":"707.738842ms","start":"2026-09-19T01:59:25.033878Z","end":"2026-09-19T01:59:25.741617Z","steps":["trace[1570632645] 'process raft request' (duration: 706.751805ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.741693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:25.033847Z","time spent":"707.797014ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:59:25.741785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.338577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ba237ffa-7182-40ae-a648-482c9e4fc288\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-19T01:59:25.741825Z","caller":"traceutil/trace.go:171","msg":"trace[1329016721] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"613.238838ms","start":"2026-09-19T01:59:25.128579Z","end":"2026-09-19T01:59:25.741818Z","steps":["trace[1329016721] 'process raft request' (duration: 612.18548ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:25.74184Z","caller":"traceutil/trace.go:171","msg":"trace[360625073] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ba237ffa-7182-40ae-a648-482c9e4fc288; range_end:; response_count:1; response_revision:5073; }","duration":"625.388999ms","start":"2026-09-19T01:59:25.116433Z","end":"2026-09-19T01:59:25.741822Z","steps":["trace[360625073] 'agreement among raft nodes before linearized reading' (duration: 625.256194ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.741869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:25.128559Z","time spent":"613.28516ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:59:25.741879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:25.11637Z","time spent":"625.499143ms","remote":"127.0.0.1:45264","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-ba237ffa-7182-40ae-a648-482c9e4fc288\" "} {"level":"warn","ts":"2026-09-19T01:59:25.741996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.891732ms","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-09-19T01:59:25.742034Z","caller":"traceutil/trace.go:171","msg":"trace[841192675] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5073; }","duration":"350.989996ms","start":"2026-09-19T01:59:25.391036Z","end":"2026-09-19T01:59:25.742026Z","steps":["trace[841192675] 'agreement among raft nodes before linearized reading' (duration: 350.893123ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.742081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:25.391017Z","time spent":"351.033897ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-19T01:59:25.742117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.956877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:59:25.74219Z","caller":"traceutil/trace.go:171","msg":"trace[1562786368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5073; }","duration":"665.068372ms","start":"2026-09-19T01:59:25.077108Z","end":"2026-09-19T01:59:25.742176Z","steps":["trace[1562786368] 'agreement among raft nodes before linearized reading' (duration: 664.945676ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.742208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.061241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-09-19T01:59:25.742237Z","caller":"traceutil/trace.go:171","msg":"trace[302455362] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5073; }","duration":"479.125074ms","start":"2026-09-19T01:59:25.263102Z","end":"2026-09-19T01:59:25.742227Z","steps":["trace[302455362] 'agreement among raft nodes before linearized reading' (duration: 479.037191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.742236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:25.077093Z","time spent":"665.132763ms","remote":"127.0.0.1:45048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T01:59:25.742245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.50321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-19T01:59:25.742266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:25.263081Z","time spent":"479.172805ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-09-19T01:59:25.742289Z","caller":"traceutil/trace.go:171","msg":"trace[1213432548] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:5073; }","duration":"109.588313ms","start":"2026-09-19T01:59:25.632689Z","end":"2026-09-19T01:59:25.742278Z","steps":["trace[1213432548] 'agreement among raft nodes before linearized reading' (duration: 109.514281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.742452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.455645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-09-19T01:59:25.742479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.953309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:59:25.742487Z","caller":"traceutil/trace.go:171","msg":"trace[1668325491] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5073; }","duration":"613.507347ms","start":"2026-09-19T01:59:25.128972Z","end":"2026-09-19T01:59:25.742479Z","steps":["trace[1668325491] 'agreement among raft nodes before linearized reading' (duration: 613.423574ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:25.742506Z","caller":"traceutil/trace.go:171","msg":"trace[2040154854] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:5073; }","duration":"101.007531ms","start":"2026-09-19T01:59:25.641491Z","end":"2026-09-19T01:59:25.742498Z","steps":["trace[2040154854] 'agreement among raft nodes before linearized reading' (duration: 100.959019ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:25.74251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:25.128966Z","time spent":"613.538158ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-19T01:59:28.261301Z","caller":"traceutil/trace.go:171","msg":"trace[451718078] transaction","detail":"{read_only:false; response_revision:5104; number_of_response:1; }","duration":"135.0903ms","start":"2026-09-19T01:59:28.126181Z","end":"2026-09-19T01:59:28.261271Z","steps":["trace[451718078] 'process raft request' (duration: 36.962437ms)","trace[451718078] 'compare' (duration: 98.016159ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:29.426928Z","caller":"traceutil/trace.go:171","msg":"trace[993833432] transaction","detail":"{read_only:false; response_revision:5118; number_of_response:1; }","duration":"133.37761ms","start":"2026-09-19T01:59:29.29352Z","end":"2026-09-19T01:59:29.426898Z","steps":["trace[993833432] 'process raft request' (duration: 133.171472ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:29.434324Z","caller":"traceutil/trace.go:171","msg":"trace[534942576] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"127.465595ms","start":"2026-09-19T01:59:29.306826Z","end":"2026-09-19T01:59:29.434291Z","steps":["trace[534942576] 'process raft request' (duration: 127.232807ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:39.008594Z","caller":"traceutil/trace.go:171","msg":"trace[738015122] linearizableReadLoop","detail":"{readStateIndex:5439; appliedIndex:5438; }","duration":"167.608662ms","start":"2026-09-19T01:59:38.840951Z","end":"2026-09-19T01:59:39.008559Z","steps":["trace[738015122] 'read index received' (duration: 167.251099ms)","trace[738015122] 'applied index is now lower than readState.Index' (duration: 353.013µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:39.008733Z","caller":"traceutil/trace.go:171","msg":"trace[1634002976] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"182.069933ms","start":"2026-09-19T01:59:38.826636Z","end":"2026-09-19T01:59:39.008706Z","steps":["trace[1634002976] 'process raft request' (duration: 181.698449ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:39.008869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.893443ms","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-09-19T01:59:39.008916Z","caller":"traceutil/trace.go:171","msg":"trace[153561965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5235; }","duration":"167.993787ms","start":"2026-09-19T01:59:38.84091Z","end":"2026-09-19T01:59:39.008904Z","steps":["trace[153561965] 'agreement among raft nodes before linearized reading' (duration: 167.807451ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:40.884719Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2832} {"level":"info","ts":"2026-09-19T01:59:41.063642Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2832,"took":"174.39428ms","hash":3630599785,"current-db-size-bytes":50552832,"current-db-size":"51 MB","current-db-size-in-use-bytes":27348992,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-19T01:59:41.063719Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3630599785,"revision":2832,"compact-revision":-1} {"level":"info","ts":"2026-09-19T01:59:42.385823Z","caller":"traceutil/trace.go:171","msg":"trace[552659365] linearizableReadLoop","detail":"{readStateIndex:5469; appliedIndex:5468; }","duration":"492.529972ms","start":"2026-09-19T01:59:41.893269Z","end":"2026-09-19T01:59:42.385799Z","steps":["trace[552659365] 'read index received' (duration: 492.315013ms)","trace[552659365] 'applied index is now lower than readState.Index' (duration: 213.559µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:42.386073Z","caller":"traceutil/trace.go:171","msg":"trace[961978615] transaction","detail":"{read_only:false; response_revision:5263; number_of_response:1; }","duration":"511.341663ms","start":"2026-09-19T01:59:41.874657Z","end":"2026-09-19T01:59:42.385998Z","steps":["trace[961978615] 'process raft request' (duration: 510.99723ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:42.386127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.830043ms","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-09-19T01:59:42.386236Z","caller":"traceutil/trace.go:171","msg":"trace[601474975] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5263; }","duration":"492.965058ms","start":"2026-09-19T01:59:41.893234Z","end":"2026-09-19T01:59:42.386199Z","steps":["trace[601474975] 'agreement among raft nodes before linearized reading' (duration: 492.694538ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:42.38631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:41.874635Z","time spent":"511.544691ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:59:42.386337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:41.893213Z","time spent":"493.061201ms","remote":"127.0.0.1:45342","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-09-19T01:59:42.386683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.651527ms","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-09-19T01:59:42.386726Z","caller":"traceutil/trace.go:171","msg":"trace[283283288] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5263; }","duration":"440.744951ms","start":"2026-09-19T01:59:41.94597Z","end":"2026-09-19T01:59:42.386715Z","steps":["trace[283283288] 'agreement among raft nodes before linearized reading' (duration: 440.561905ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:42.386791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:41.94596Z","time spent":"440.821714ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-19T01:59:42.387248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.324189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-19T01:59:42.387363Z","caller":"traceutil/trace.go:171","msg":"trace[728328129] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5263; }","duration":"286.399162ms","start":"2026-09-19T01:59:42.100875Z","end":"2026-09-19T01:59:42.387274Z","steps":["trace[728328129] 'agreement among raft nodes before linearized reading' (duration: 286.267407ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:42.387628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.090193ms","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-09-19T01:59:42.387676Z","caller":"traceutil/trace.go:171","msg":"trace[1007302004] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5263; }","duration":"414.136864ms","start":"2026-09-19T01:59:41.973526Z","end":"2026-09-19T01:59:42.387663Z","steps":["trace[1007302004] 'agreement among raft nodes before linearized reading' (duration: 413.976538ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:42.387712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:41.973496Z","time spent":"414.208887ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-19T01:59:43.134641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.335619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:59:43.135572Z","caller":"traceutil/trace.go:171","msg":"trace[1239558982] transaction","detail":"{read_only:false; response_revision:5264; number_of_response:1; }","duration":"741.038016ms","start":"2026-09-19T01:59:42.394319Z","end":"2026-09-19T01:59:43.135357Z","steps":["trace[1239558982] 'process raft request' (duration: 87.828126ms)","trace[1239558982] 'compare' (duration: 651.871401ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:59:43.135824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:42.394268Z","time spent":"741.506704ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:59:43.517533Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.035376529s","expected-duration":"1s"} {"level":"info","ts":"2026-09-19T01:59:43.518231Z","caller":"traceutil/trace.go:171","msg":"trace[143802873] transaction","detail":"{read_only:false; response_revision:5265; number_of_response:1; }","duration":"1.116462057s","start":"2026-09-19T01:59:42.401727Z","end":"2026-09-19T01:59:43.518189Z","steps":["trace[143802873] 'process raft request' (duration: 1.116067523s)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.518557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:42.401696Z","time spent":"1.116693795s","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:59:43.518679Z","caller":"traceutil/trace.go:171","msg":"trace[542672165] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"1.116772109s","start":"2026-09-19T01:59:42.401865Z","end":"2026-09-19T01:59:43.518637Z","steps":["trace[542672165] 'process raft request' (duration: 1.116204147s)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:43.518677Z","caller":"traceutil/trace.go:171","msg":"trace[607378768] linearizableReadLoop","detail":"{readStateIndex:5473; appliedIndex:5469; }","duration":"1.107324812s","start":"2026-09-19T01:59:42.411312Z","end":"2026-09-19T01:59:43.518637Z","steps":["trace[607378768] 'read index received' (duration: 70.849272ms)","trace[607378768] 'applied index is now lower than readState.Index' (duration: 1.03647364s)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:59:43.518817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:42.401853Z","time spent":"1.116889503s","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:59:43.518777Z","caller":"traceutil/trace.go:171","msg":"trace[956849962] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"1.115025475s","start":"2026-09-19T01:59:42.403631Z","end":"2026-09-19T01:59:43.518657Z","steps":["trace[956849962] 'process raft request' (duration: 1.114836037s)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.519185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:42.403624Z","time spent":"1.115374218s","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:59:43.519292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.107940434s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-09-19T01:59:43.519383Z","caller":"traceutil/trace.go:171","msg":"trace[166857060] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5267; }","duration":"1.10810144s","start":"2026-09-19T01:59:42.411265Z","end":"2026-09-19T01:59:43.519367Z","steps":["trace[166857060] 'agreement among raft nodes before linearized reading' (duration: 1.10753628s)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.519447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:42.411248Z","time spent":"1.108186753s","remote":"127.0.0.1:45264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10415,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-09-19T01:59:43.576594Z","caller":"traceutil/trace.go:171","msg":"trace[1918449956] transaction","detail":"{read_only:false; response_revision:5269; number_of_response:1; }","duration":"531.928203ms","start":"2026-09-19T01:59:43.044618Z","end":"2026-09-19T01:59:43.576546Z","steps":["trace[1918449956] 'process raft request' (duration: 531.787938ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.57669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.160404863s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-19T01:59:43.576802Z","caller":"traceutil/trace.go:171","msg":"trace[970606082] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5269; }","duration":"1.160576039s","start":"2026-09-19T01:59:42.416198Z","end":"2026-09-19T01:59:43.576774Z","steps":["trace[970606082] 'agreement among raft nodes before linearized reading' (duration: 1.160263908s)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.576884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:42.41616Z","time spent":"1.160711044s","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-09-19T01:59:43.577024Z","caller":"traceutil/trace.go:171","msg":"trace[857002932] transaction","detail":"{read_only:false; response_revision:5268; number_of_response:1; }","duration":"763.267723ms","start":"2026-09-19T01:59:42.813723Z","end":"2026-09-19T01:59:43.57699Z","steps":["trace[857002932] 'process raft request' (duration: 762.425073ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.577098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.340062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-19T01:59:43.577195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:42.813692Z","time spent":"763.393637ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:59:43.577223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.93507ms","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-09-19T01:59:43.577258Z","caller":"traceutil/trace.go:171","msg":"trace[681150892] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5269; }","duration":"497.599421ms","start":"2026-09-19T01:59:43.079632Z","end":"2026-09-19T01:59:43.577231Z","steps":["trace[681150892] 'agreement among raft nodes before linearized reading' (duration: 497.342841ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:43.577278Z","caller":"traceutil/trace.go:171","msg":"trace[317441385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5269; }","duration":"496.018283ms","start":"2026-09-19T01:59:43.081245Z","end":"2026-09-19T01:59:43.577263Z","steps":["trace[317441385] 'agreement among raft nodes before linearized reading' (duration: 495.67479ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.577354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:43.081232Z","time spent":"496.109998ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-19T01:59:43.577369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:43.079583Z","time spent":"497.758988ms","remote":"127.0.0.1:45048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T01:59:43.576849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:59:43.044581Z","time spent":"532.133981ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:59:43.781603Z","caller":"traceutil/trace.go:171","msg":"trace[726001218] linearizableReadLoop","detail":"{readStateIndex:5476; appliedIndex:5475; }","duration":"202.647628ms","start":"2026-09-19T01:59:43.578922Z","end":"2026-09-19T01:59:43.78157Z","steps":["trace[726001218] 'read index received' (duration: 202.251644ms)","trace[726001218] 'applied index is now lower than readState.Index' (duration: 394.364µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:59:43.781758Z","caller":"traceutil/trace.go:171","msg":"trace[433630823] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"244.713686ms","start":"2026-09-19T01:59:43.53703Z","end":"2026-09-19T01:59:43.781744Z","steps":["trace[433630823] 'process raft request' (duration: 244.246478ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.781893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.124697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:59:43.782001Z","caller":"traceutil/trace.go:171","msg":"trace[754720206] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5270; }","duration":"203.259753ms","start":"2026-09-19T01:59:43.578706Z","end":"2026-09-19T01:59:43.781965Z","steps":["trace[754720206] 'agreement among raft nodes before linearized reading' (duration: 203.091307ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.793479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.852007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-ba237ffa-7182-40ae-a648-482c9e4fc288\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-09-19T01:59:43.793568Z","caller":"traceutil/trace.go:171","msg":"trace[5331324] range","detail":"{range_begin:/registry/persistentvolumes/pvc-ba237ffa-7182-40ae-a648-482c9e4fc288; range_end:; response_count:1; response_revision:5271; }","duration":"211.972942ms","start":"2026-09-19T01:59:43.581573Z","end":"2026-09-19T01:59:43.793546Z","steps":["trace[5331324] 'agreement among raft nodes before linearized reading' (duration: 211.705422ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:43.794115Z","caller":"traceutil/trace.go:171","msg":"trace[774885080] transaction","detail":"{read_only:false; response_revision:5271; number_of_response:1; }","duration":"210.56204ms","start":"2026-09-19T01:59:43.583511Z","end":"2026-09-19T01:59:43.794073Z","steps":["trace[774885080] 'process raft request' (duration: 209.595725ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.794549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.705678ms","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-09-19T01:59:43.794644Z","caller":"traceutil/trace.go:171","msg":"trace[587905083] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5271; }","duration":"138.868955ms","start":"2026-09-19T01:59:43.655753Z","end":"2026-09-19T01:59:43.794622Z","steps":["trace[587905083] 'agreement among raft nodes before linearized reading' (duration: 138.253512ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:59:43.794793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.184638ms","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-09-19T01:59:43.794883Z","caller":"traceutil/trace.go:171","msg":"trace[374264837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5271; }","duration":"117.316863ms","start":"2026-09-19T01:59:43.677527Z","end":"2026-09-19T01:59:43.794844Z","steps":["trace[374264837] 'agreement among raft nodes before linearized reading' (duration: 116.4487ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:59:52.632701Z","caller":"traceutil/trace.go:171","msg":"trace[1178957108] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"104.383777ms","start":"2026-09-19T01:59:52.528262Z","end":"2026-09-19T01:59:52.632646Z","steps":["trace[1178957108] 'process raft request' (duration: 104.098927ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:17.82836Z","caller":"traceutil/trace.go:171","msg":"trace[571979362] transaction","detail":"{read_only:false; response_revision:5591; number_of_response:1; }","duration":"112.152724ms","start":"2026-09-19T02:00:17.716181Z","end":"2026-09-19T02:00:17.828334Z","steps":["trace[571979362] 'process raft request' (duration: 112.000318ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:28.236661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.859961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T02:00:28.236788Z","caller":"traceutil/trace.go:171","msg":"trace[1523673387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5654; }","duration":"158.021177ms","start":"2026-09-19T02:00:28.078739Z","end":"2026-09-19T02:00:28.236761Z","steps":["trace[1523673387] 'range keys from in-memory index tree' (duration: 157.711265ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:28.236682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.758928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T02:00:28.237074Z","caller":"traceutil/trace.go:171","msg":"trace[1945578842] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:5654; }","duration":"112.141154ms","start":"2026-09-19T02:00:28.124847Z","end":"2026-09-19T02:00:28.236988Z","steps":["trace[1945578842] 'count revisions from in-memory index tree' (duration: 111.625613ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:28.239035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.311117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-19T02:00:28.239111Z","caller":"traceutil/trace.go:171","msg":"trace[1243923721] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5654; }","duration":"138.438611ms","start":"2026-09-19T02:00:28.100655Z","end":"2026-09-19T02:00:28.239094Z","steps":["trace[1243923721] 'range keys from in-memory index tree' (duration: 135.656968ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:36.087178Z","caller":"traceutil/trace.go:171","msg":"trace[1401863893] linearizableReadLoop","detail":"{readStateIndex:5934; appliedIndex:5933; }","duration":"211.068013ms","start":"2026-09-19T02:00:35.876087Z","end":"2026-09-19T02:00:36.087155Z","steps":["trace[1401863893] 'read index received' (duration: 210.847015ms)","trace[1401863893] 'applied index is now lower than readState.Index' (duration: 219.908µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:00:36.087238Z","caller":"traceutil/trace.go:171","msg":"trace[1583290250] transaction","detail":"{read_only:false; response_revision:5715; number_of_response:1; }","duration":"253.150688ms","start":"2026-09-19T02:00:35.834056Z","end":"2026-09-19T02:00:36.087206Z","steps":["trace[1583290250] 'process raft request' (duration: 252.864267ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:36.087314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.216348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T02:00:36.087545Z","caller":"traceutil/trace.go:171","msg":"trace[833058158] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5715; }","duration":"211.378515ms","start":"2026-09-19T02:00:35.875998Z","end":"2026-09-19T02:00:36.087376Z","steps":["trace[833058158] 'agreement among raft nodes before linearized reading' (duration: 211.23913ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:36.177015Z","caller":"traceutil/trace.go:171","msg":"trace[924122232] transaction","detail":"{read_only:false; response_revision:5716; number_of_response:1; }","duration":"237.745639ms","start":"2026-09-19T02:00:35.939249Z","end":"2026-09-19T02:00:36.176994Z","steps":["trace[924122232] 'process raft request' (duration: 237.552832ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:36.177207Z","caller":"traceutil/trace.go:171","msg":"trace[1406525815] transaction","detail":"{read_only:false; response_revision:5717; number_of_response:1; }","duration":"228.356807ms","start":"2026-09-19T02:00:35.948841Z","end":"2026-09-19T02:00:36.177198Z","steps":["trace[1406525815] 'process raft request' (duration: 228.080636ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:36.177709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.17826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T02:00:36.177804Z","caller":"traceutil/trace.go:171","msg":"trace[1438753601] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5717; }","duration":"301.330385ms","start":"2026-09-19T02:00:35.87645Z","end":"2026-09-19T02:00:36.177781Z","steps":["trace[1438753601] 'agreement among raft nodes before linearized reading' (duration: 301.143048ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:36.177798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.172831ms","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-09-19T02:00:36.177818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.514995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-19T02:00:36.177869Z","caller":"traceutil/trace.go:171","msg":"trace[147006781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5717; }","duration":"158.292626ms","start":"2026-09-19T02:00:36.019556Z","end":"2026-09-19T02:00:36.177848Z","steps":["trace[147006781] 'agreement among raft nodes before linearized reading' (duration: 158.086259ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:00:36.177882Z","caller":"traceutil/trace.go:171","msg":"trace[138266871] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5717; }","duration":"110.63273ms","start":"2026-09-19T02:00:36.067229Z","end":"2026-09-19T02:00:36.177862Z","steps":["trace[138266871] 'agreement among raft nodes before linearized reading' (duration: 110.408011ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:00:36.177889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T02:00:35.876428Z","time spent":"301.420118ms","remote":"127.0.0.1:45318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" "} {"level":"info","ts":"2026-09-19T02:01:02.533142Z","caller":"traceutil/trace.go:171","msg":"trace[1443936965] linearizableReadLoop","detail":"{readStateIndex:6136; appliedIndex:6135; }","duration":"103.910321ms","start":"2026-09-19T02:01:02.429198Z","end":"2026-09-19T02:01:02.533109Z","steps":["trace[1443936965] 'read index received' (duration: 24.99341ms)","trace[1443936965] 'applied index is now lower than readState.Index' (duration: 78.916241ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:01:02.533292Z","caller":"traceutil/trace.go:171","msg":"trace[765618271] transaction","detail":"{read_only:false; response_revision:5912; number_of_response:1; }","duration":"106.156317ms","start":"2026-09-19T02:01:02.427084Z","end":"2026-09-19T02:01:02.53324Z","steps":["trace[765618271] 'process raft request' (duration: 105.895677ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:01:02.533622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.385187ms","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-09-19T02:01:02.5337Z","caller":"traceutil/trace.go:171","msg":"trace[449259928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5912; }","duration":"100.49655ms","start":"2026-09-19T02:01:02.433185Z","end":"2026-09-19T02:01:02.533681Z","steps":["trace[449259928] 'agreement among raft nodes before linearized reading' (duration: 100.283782ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:01:02.533843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.627908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-19T02:01:02.533914Z","caller":"traceutil/trace.go:171","msg":"trace[1897136474] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5912; }","duration":"104.696031ms","start":"2026-09-19T02:01:02.429174Z","end":"2026-09-19T02:01:02.53387Z","steps":["trace[1897136474] 'agreement among raft nodes before linearized reading' (duration: 104.469362ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:06.898457Z","caller":"traceutil/trace.go:171","msg":"trace[1288957768] transaction","detail":"{read_only:false; response_revision:6285; number_of_response:1; }","duration":"227.589146ms","start":"2026-09-19T02:02:06.670802Z","end":"2026-09-19T02:02:06.898391Z","steps":["trace[1288957768] 'process raft request' (duration: 227.387619ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:02:06.990481Z","caller":"traceutil/trace.go:171","msg":"trace[627627228] linearizableReadLoop","detail":"{readStateIndex:6523; appliedIndex:6521; }","duration":"180.648744ms","start":"2026-09-19T02:02:06.809813Z","end":"2026-09-19T02:02:06.990462Z","steps":["trace[627627228] 'read index received' (duration: 88.406313ms)","trace[627627228] 'applied index is now lower than readState.Index' (duration: 92.241471ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T02:02:06.990533Z","caller":"traceutil/trace.go:171","msg":"trace[94070250] transaction","detail":"{read_only:false; response_revision:6286; number_of_response:1; }","duration":"318.251576ms","start":"2026-09-19T02:02:06.672266Z","end":"2026-09-19T02:02:06.990518Z","steps":["trace[94070250] 'process raft request' (duration: 281.741516ms)","trace[94070250] 'compare' (duration: 36.330433ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T02:02:06.990678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.851391ms","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-09-19T02:02:06.990715Z","caller":"traceutil/trace.go:171","msg":"trace[668266084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6286; }","duration":"180.943635ms","start":"2026-09-19T02:02:06.809762Z","end":"2026-09-19T02:02:06.990706Z","steps":["trace[668266084] 'agreement among raft nodes before linearized reading' (duration: 180.824371ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:02:06.990678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.936937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T02:02:06.990858Z","caller":"traceutil/trace.go:171","msg":"trace[1280417908] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:6286; }","duration":"173.122423ms","start":"2026-09-19T02:02:06.817725Z","end":"2026-09-19T02:02:06.990848Z","steps":["trace[1280417908] 'agreement among raft nodes before linearized reading' (duration: 172.877804ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:02:06.990965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.06177ms","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-09-19T02:02:06.991014Z","caller":"traceutil/trace.go:171","msg":"trace[1477612190] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6286; }","duration":"167.143872ms","start":"2026-09-19T02:02:06.823847Z","end":"2026-09-19T02:02:06.99099Z","steps":["trace[1477612190] 'agreement among raft nodes before linearized reading' (duration: 166.985026ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T02:02:06.99127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T02:02:06.672237Z","time spent":"318.88108ms","remote":"127.0.0.1:45342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T02:02:12.321551Z","caller":"traceutil/trace.go:171","msg":"trace[434522434] transaction","detail":"{read_only:false; response_revision:6314; number_of_response:1; }","duration":"128.835319ms","start":"2026-09-19T02:02:12.192636Z","end":"2026-09-19T02:02:12.321471Z","steps":["trace[434522434] 'process raft request' (duration: 128.60749ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T02:04:40.900069Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5251} {"level":"info","ts":"2026-09-19T02:04:40.974152Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5251,"took":"72.856334ms","hash":1811449337,"current-db-size-bytes":50552832,"current-db-size":"51 MB","current-db-size-in-use-bytes":18731008,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-19T02:04:40.97424Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1811449337,"revision":5251,"compact-revision":2832}