{"level":"warn","ts":"2026-09-19T00:56:50.145441Z","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-19T00:56:50.145534Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.93: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.93:2380","--initial-cluster=instance=https://162.253.55.93:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.93:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.93: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-19T00:56:50.14562Z","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-19T00:56:50.145629Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.93:2380"]} {"level":"info","ts":"2026-09-19T00:56:50.145653Z","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-19T00:56:50.146308Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.93:2379"]} {"level":"info","ts":"2026-09-19T00:56:50.146409Z","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.93:2380"],"listen-peer-urls":["https://162.253.55.93:2380"],"advertise-client-urls":["https://162.253.55.93:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.93:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.93: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-19T00:56:50.150872Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.241232ms"} {"level":"info","ts":"2026-09-19T00:56:50.161144Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ea06c5748459930b","cluster-id":"49d4e1d71c75bc5"} {"level":"info","ts":"2026-09-19T00:56:50.161236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T00:56:50.161264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b became follower at term 0"} {"level":"info","ts":"2026-09-19T00:56:50.161279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ea06c5748459930b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T00:56:50.161296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b became follower at term 1"} {"level":"info","ts":"2026-09-19T00:56:50.161353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b switched to configuration voters=(16863382958962742027)"} {"level":"warn","ts":"2026-09-19T00:56:50.172892Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T00:56:50.174569Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T00:56:50.177402Z","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-19T00:56:50.182165Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ea06c5748459930b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T00:56:50.182428Z","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-19T00:56:50.182374Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ea06c5748459930b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T00:56:50.183083Z","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-19T00:56:50.18316Z","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-19T00:56:50.185938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b switched to configuration voters=(16863382958962742027)"} {"level":"info","ts":"2026-09-19T00:56:50.186074Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49d4e1d71c75bc5","local-member-id":"ea06c5748459930b","added-peer-id":"ea06c5748459930b","added-peer-peer-urls":["https://162.253.55.93:2380"]} {"level":"info","ts":"2026-09-19T00:56:50.187087Z","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-19T00:56:50.187165Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.93:2380"} {"level":"info","ts":"2026-09-19T00:56:50.187209Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.93:2380"} {"level":"info","ts":"2026-09-19T00:56:50.187421Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ea06c5748459930b","initial-advertise-peer-urls":["https://162.253.55.93:2380"],"listen-peer-urls":["https://162.253.55.93:2380"],"advertise-client-urls":["https://162.253.55.93:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.93:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T00:56:50.187451Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T00:56:51.061547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T00:56:51.061598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T00:56:51.061614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b received MsgPreVoteResp from ea06c5748459930b at term 1"} {"level":"info","ts":"2026-09-19T00:56:51.06163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b became candidate at term 2"} {"level":"info","ts":"2026-09-19T00:56:51.061639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b received MsgVoteResp from ea06c5748459930b at term 2"} {"level":"info","ts":"2026-09-19T00:56:51.061653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ea06c5748459930b became leader at term 2"} {"level":"info","ts":"2026-09-19T00:56:51.061666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ea06c5748459930b elected leader ea06c5748459930b at term 2"} {"level":"info","ts":"2026-09-19T00:56:51.064032Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ea06c5748459930b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.93:2379]}","request-path":"/0/members/ea06c5748459930b/attributes","cluster-id":"49d4e1d71c75bc5","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T00:56:51.064132Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T00:56:51.064192Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T00:56:51.064236Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T00:56:51.064376Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T00:56:51.064513Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T00:56:51.064917Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49d4e1d71c75bc5","local-member-id":"ea06c5748459930b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T00:56:51.064995Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T00:56:51.065015Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T00:56:51.066168Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.93:2379"} {"level":"info","ts":"2026-09-19T00:56:51.067496Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T00:56:53.124757Z","caller":"traceutil/trace.go:171","msg":"trace[909170202] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"239.121504ms","start":"2026-09-19T00:56:52.885593Z","end":"2026-09-19T00:56:53.124715Z","steps":["trace[909170202] 'process raft request' (duration: 172.874037ms)","trace[909170202] 'compare' (duration: 66.090343ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:56:53.277079Z","caller":"traceutil/trace.go:171","msg":"trace[1234418152] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"135.574078ms","start":"2026-09-19T00:56:53.141464Z","end":"2026-09-19T00:56:53.277038Z","steps":["trace[1234418152] 'process raft request' (duration: 131.554313ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:56:53.540558Z","caller":"traceutil/trace.go:171","msg":"trace[2105042767] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"182.253316ms","start":"2026-09-19T00:56:53.358259Z","end":"2026-09-19T00:56:53.540512Z","steps":["trace[2105042767] 'process raft request' (duration: 180.255039ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:01.087606Z","caller":"traceutil/trace.go:171","msg":"trace[3144234] linearizableReadLoop","detail":"{readStateIndex:396; appliedIndex:395; }","duration":"200.317027ms","start":"2026-09-19T00:57:00.887274Z","end":"2026-09-19T00:57:01.087591Z","steps":["trace[3144234] 'read index received' (duration: 200.274177ms)","trace[3144234] 'applied index is now lower than readState.Index' (duration: 42.34µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T00:57:01.087722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.427361ms","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-19T00:57:01.087764Z","caller":"traceutil/trace.go:171","msg":"trace[2064657701] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:386; }","duration":"200.509962ms","start":"2026-09-19T00:57:00.887239Z","end":"2026-09-19T00:57:01.087749Z","steps":["trace[2064657701] 'agreement among raft nodes before linearized reading' (duration: 200.4167ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:01.087956Z","caller":"traceutil/trace.go:171","msg":"trace[131267366] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"315.370311ms","start":"2026-09-19T00:57:00.772581Z","end":"2026-09-19T00:57:01.087951Z","steps":["trace[131267366] 'process raft request' (duration: 314.87738ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:01.088239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:00.772566Z","time spent":"315.404212ms","remote":"127.0.0.1:42704","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-19T00:57:29.310065Z","caller":"traceutil/trace.go:171","msg":"trace[121739596] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"145.309144ms","start":"2026-09-19T00:57:29.164647Z","end":"2026-09-19T00:57:29.309956Z","steps":["trace[121739596] 'process raft request' (duration: 145.12362ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:29.669858Z","caller":"traceutil/trace.go:171","msg":"trace[1385608604] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:546; }","duration":"418.522576ms","start":"2026-09-19T00:57:29.25131Z","end":"2026-09-19T00:57:29.669833Z","steps":["trace[1385608604] 'read index received' (duration: 58.589129ms)","trace[1385608604] 'applied index is now lower than readState.Index' (duration: 359.932587ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:57:29.670064Z","caller":"traceutil/trace.go:171","msg":"trace[1607257450] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"463.347757ms","start":"2026-09-19T00:57:29.20668Z","end":"2026-09-19T00:57:29.670027Z","steps":["trace[1607257450] 'process raft request' (duration: 462.884607ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:29.670094Z","caller":"traceutil/trace.go:171","msg":"trace[993928278] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"484.749168ms","start":"2026-09-19T00:57:29.185319Z","end":"2026-09-19T00:57:29.670068Z","steps":["trace[993928278] 'process raft request' (duration: 484.152547ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:29.670217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.206656Z","time spent":"463.490109ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:57:29.670244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.185315Z","time spent":"484.83209ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:57:29.670228Z","caller":"traceutil/trace.go:171","msg":"trace[1974403234] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"502.957049ms","start":"2026-09-19T00:57:29.167232Z","end":"2026-09-19T00:57:29.670189Z","steps":["trace[1974403234] 'process raft request' (duration: 502.160744ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:29.670324Z","caller":"traceutil/trace.go:171","msg":"trace[2050201015] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"472.101091ms","start":"2026-09-19T00:57:29.198211Z","end":"2026-09-19T00:57:29.670312Z","steps":["trace[2050201015] 'process raft request' (duration: 471.317756ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:29.670358Z","caller":"traceutil/trace.go:171","msg":"trace[737926538] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"436.241588ms","start":"2026-09-19T00:57:29.234106Z","end":"2026-09-19T00:57:29.670348Z","steps":["trace[737926538] 'process raft request' (duration: 435.633186ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:29.670408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.234082Z","time spent":"436.30419ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:57:29.670425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.198196Z","time spent":"472.162311ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:57:29.670498Z","caller":"traceutil/trace.go:171","msg":"trace[1110565939] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"454.950579ms","start":"2026-09-19T00:57:29.215518Z","end":"2026-09-19T00:57:29.670469Z","steps":["trace[1110565939] 'process raft request' (duration: 454.132474ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:29.670411Z","caller":"traceutil/trace.go:171","msg":"trace[1285041970] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"427.77603ms","start":"2026-09-19T00:57:29.242618Z","end":"2026-09-19T00:57:29.670394Z","steps":["trace[1285041970] 'process raft request' (duration: 427.170428ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:29.670554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.2155Z","time spent":"455.02078ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:57:29.670425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.167216Z","time spent":"503.117452ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:57:29.670624Z","caller":"traceutil/trace.go:171","msg":"trace[112678602] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"451.522035ms","start":"2026-09-19T00:57:29.219094Z","end":"2026-09-19T00:57:29.670616Z","steps":["trace[112678602] 'process raft request' (duration: 450.597227ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:29.670657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.219075Z","time spent":"451.566516ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:57:29.670225Z","caller":"traceutil/trace.go:171","msg":"trace[1661561752] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"505.14625ms","start":"2026-09-19T00:57:29.165004Z","end":"2026-09-19T00:57:29.67015Z","steps":["trace[1661561752] 'process raft request' (duration: 504.245303ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:29.67073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.164968Z","time spent":"505.72343ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:57:29.670743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.423183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-19T00:57:29.670842Z","caller":"traceutil/trace.go:171","msg":"trace[567816701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:539; }","duration":"419.550946ms","start":"2026-09-19T00:57:29.251278Z","end":"2026-09-19T00:57:29.670829Z","steps":["trace[567816701] 'agreement among raft nodes before linearized reading' (duration: 419.340512ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:29.671007Z","caller":"traceutil/trace.go:171","msg":"trace[2124119356] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"485.676165ms","start":"2026-09-19T00:57:29.185261Z","end":"2026-09-19T00:57:29.670938Z","steps":["trace[2124119356] 'process raft request' (duration: 484.172567ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:29.671213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.185244Z","time spent":"485.899479ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:57:29.670941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.25127Z","time spent":"419.659008ms","remote":"127.0.0.1:42704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-19T00:57:29.672217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.242607Z","time spent":"427.959243ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T00:57:29.707103Z","caller":"traceutil/trace.go:171","msg":"trace[1753805782] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"388.065855ms","start":"2026-09-19T00:57:29.318992Z","end":"2026-09-19T00:57:29.707057Z","steps":["trace[1753805782] 'process raft request' (duration: 387.940643ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:29.707188Z","caller":"traceutil/trace.go:171","msg":"trace[1915316059] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"389.819287ms","start":"2026-09-19T00:57:29.31735Z","end":"2026-09-19T00:57:29.707169Z","steps":["trace[1915316059] 'process raft request' (duration: 389.458891ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:29.707265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.317334Z","time spent":"389.890538ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:57:29.707284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.318979Z","time spent":"388.207247ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T00:57:29.7073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.834624ms","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-19T00:57:29.707544Z","caller":"traceutil/trace.go:171","msg":"trace[2025502404] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:542; }","duration":"393.118408ms","start":"2026-09-19T00:57:29.314407Z","end":"2026-09-19T00:57:29.707525Z","steps":["trace[2025502404] 'agreement among raft nodes before linearized reading' (duration: 392.772762ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:29.707769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.314389Z","time spent":"393.362983ms","remote":"127.0.0.1:42704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-19T00:57:29.707637Z","caller":"traceutil/trace.go:171","msg":"trace[768440319] transaction","detail":"{read_only:false; number_of_response:1; response_revision:541; }","duration":"388.554443ms","start":"2026-09-19T00:57:29.319069Z","end":"2026-09-19T00:57:29.707623Z","steps":["trace[768440319] 'process raft request' (duration: 387.911422ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:29.70807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.319062Z","time spent":"388.957611ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T00:57:29.707691Z","caller":"traceutil/trace.go:171","msg":"trace[367275562] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"366.060001ms","start":"2026-09-19T00:57:29.341624Z","end":"2026-09-19T00:57:29.707684Z","steps":["trace[367275562] 'process raft request' (duration: 365.484801ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:29.70832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:29.341606Z","time spent":"366.666144ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T00:57:36.095749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.974768ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T00:57:36.095851Z","caller":"traceutil/trace.go:171","msg":"trace[826581181] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"287.595831ms","start":"2026-09-19T00:57:35.808239Z","end":"2026-09-19T00:57:36.095835Z","steps":["trace[826581181] 'read index received' (duration: 29.025727ms)","trace[826581181] 'applied index is now lower than readState.Index' (duration: 258.569024ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:57:36.095906Z","caller":"traceutil/trace.go:171","msg":"trace[314913650] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"300.268471ms","start":"2026-09-19T00:57:35.795608Z","end":"2026-09-19T00:57:36.095877Z","steps":["trace[314913650] 'process raft request' (duration: 99.950327ms)","trace[314913650] 'compare' (duration: 199.813956ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T00:57:36.096025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.780244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T00:57:36.096055Z","caller":"traceutil/trace.go:171","msg":"trace[1051167440] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:638; }","duration":"287.836555ms","start":"2026-09-19T00:57:35.808208Z","end":"2026-09-19T00:57:36.096044Z","steps":["trace[1051167440] 'agreement among raft nodes before linearized reading' (duration: 287.723763ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:36.096073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:35.795588Z","time spent":"300.385333ms","remote":"127.0.0.1:42704","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-19T00:57:36.61559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.166487ms","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-19T00:57:36.615662Z","caller":"traceutil/trace.go:171","msg":"trace[2035760739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"229.254299ms","start":"2026-09-19T00:57:36.38639Z","end":"2026-09-19T00:57:36.615644Z","steps":["trace[2035760739] 'range keys from in-memory index tree' (duration: 228.973983ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:36.615675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.64575ms","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-19T00:57:36.615748Z","caller":"traceutil/trace.go:171","msg":"trace[402179778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"284.795462ms","start":"2026-09-19T00:57:36.330935Z","end":"2026-09-19T00:57:36.615731Z","steps":["trace[402179778] 'range keys from in-memory index tree' (duration: 284.452417ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:36.732613Z","caller":"traceutil/trace.go:171","msg":"trace[1247909232] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"225.781316ms","start":"2026-09-19T00:57:36.506809Z","end":"2026-09-19T00:57:36.732591Z","steps":["trace[1247909232] 'process raft request' (duration: 225.075973ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:36.735716Z","caller":"traceutil/trace.go:171","msg":"trace[407690621] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"115.635243ms","start":"2026-09-19T00:57:36.620044Z","end":"2026-09-19T00:57:36.735679Z","steps":["trace[407690621] 'process raft request' (duration: 115.311657ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:36.735789Z","caller":"traceutil/trace.go:171","msg":"trace[1551763979] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"115.628703ms","start":"2026-09-19T00:57:36.620096Z","end":"2026-09-19T00:57:36.735725Z","steps":["trace[1551763979] 'process raft request' (duration: 115.414869ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:57:38.354109Z","caller":"traceutil/trace.go:171","msg":"trace[1188974178] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"128.040165ms","start":"2026-09-19T00:57:38.226043Z","end":"2026-09-19T00:57:38.354083Z","steps":["trace[1188974178] 'process raft request' (duration: 127.924743ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:53.510054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.035595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xmx8t\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-19T00:57:53.510142Z","caller":"traceutil/trace.go:171","msg":"trace[1886754805] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xmx8t; range_end:; response_count:1; response_revision:805; }","duration":"337.190298ms","start":"2026-09-19T00:57:53.172933Z","end":"2026-09-19T00:57:53.510123Z","steps":["trace[1886754805] 'range keys from in-memory index tree' (duration: 336.789571ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:57:53.510195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:57:53.172914Z","time spent":"337.26069ms","remote":"127.0.0.1:42618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xmx8t\" "} {"level":"info","ts":"2026-09-19T00:58:42.554741Z","caller":"traceutil/trace.go:171","msg":"trace[783175854] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"148.792123ms","start":"2026-09-19T00:58:42.405914Z","end":"2026-09-19T00:58:42.554706Z","steps":["trace[783175854] 'process raft request' (duration: 54.986706ms)","trace[783175854] 'compare' (duration: 93.565454ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:58:42.901597Z","caller":"traceutil/trace.go:171","msg":"trace[689100228] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"341.514584ms","start":"2026-09-19T00:58:42.560051Z","end":"2026-09-19T00:58:42.901566Z","steps":["trace[689100228] 'process raft request' (duration: 336.594193ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:58:42.901766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:58:42.560027Z","time spent":"341.641825ms","remote":"127.0.0.1:42704","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-19T00:59:15.24713Z","caller":"traceutil/trace.go:171","msg":"trace[443649416] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1951; }","duration":"173.899688ms","start":"2026-09-19T00:59:15.073199Z","end":"2026-09-19T00:59:15.247098Z","steps":["trace[443649416] 'read index received' (duration: 173.564024ms)","trace[443649416] 'applied index is now lower than readState.Index' (duration: 334.274µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:59:15.247205Z","caller":"traceutil/trace.go:171","msg":"trace[1436881529] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"258.644847ms","start":"2026-09-19T00:59:14.988528Z","end":"2026-09-19T00:59:15.247173Z","steps":["trace[1436881529] 'process raft request' (duration: 258.352263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:59:15.24744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.223612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-19T00:59:15.247505Z","caller":"traceutil/trace.go:171","msg":"trace[1670839596] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1880; }","duration":"174.361874ms","start":"2026-09-19T00:59:15.073123Z","end":"2026-09-19T00:59:15.247485Z","steps":["trace[1670839596] 'agreement among raft nodes before linearized reading' (duration: 174.156261ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:59:15.825292Z","caller":"traceutil/trace.go:171","msg":"trace[1961846882] linearizableReadLoop","detail":"{readStateIndex:1957; appliedIndex:1956; }","duration":"217.978001ms","start":"2026-09-19T00:59:15.607284Z","end":"2026-09-19T00:59:15.825262Z","steps":["trace[1961846882] 'read index received' (duration: 217.692088ms)","trace[1961846882] 'applied index is now lower than readState.Index' (duration: 284.803µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:59:15.825347Z","caller":"traceutil/trace.go:171","msg":"trace[1377403482] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"238.036725ms","start":"2026-09-19T00:59:15.587279Z","end":"2026-09-19T00:59:15.825315Z","steps":["trace[1377403482] 'process raft request' (duration: 237.721251ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:59:15.825463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.157633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T00:59:15.825554Z","caller":"traceutil/trace.go:171","msg":"trace[247563648] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1885; }","duration":"218.309736ms","start":"2026-09-19T00:59:15.60723Z","end":"2026-09-19T00:59:15.825539Z","steps":["trace[247563648] 'agreement among raft nodes before linearized reading' (duration: 218.149674ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:59:15.826051Z","caller":"traceutil/trace.go:171","msg":"trace[705331440] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"135.593415ms","start":"2026-09-19T00:59:15.690405Z","end":"2026-09-19T00:59:15.825998Z","steps":["trace[705331440] 'process raft request' (duration: 135.428173ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:59:44.800589Z","caller":"traceutil/trace.go:171","msg":"trace[658439226] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"103.017253ms","start":"2026-09-19T00:59:44.697485Z","end":"2026-09-19T00:59:44.800502Z","steps":["trace[658439226] 'process raft request' (duration: 99.024361ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:59:50.957065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.710191ms","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-19T00:59:50.957169Z","caller":"traceutil/trace.go:171","msg":"trace[427334288] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2132; }","duration":"268.859712ms","start":"2026-09-19T00:59:50.688291Z","end":"2026-09-19T00:59:50.957151Z","steps":["trace[427334288] 'range keys from in-memory index tree' (duration: 268.512448ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:59:50.95708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.320683ms","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-19T00:59:50.957266Z","caller":"traceutil/trace.go:171","msg":"trace[482918400] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2132; }","duration":"368.547625ms","start":"2026-09-19T00:59:50.588688Z","end":"2026-09-19T00:59:50.957236Z","steps":["trace[482918400] 'range keys from in-memory index tree' (duration: 368.09776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:59:50.957323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:59:50.588666Z","time spent":"368.640237ms","remote":"127.0.0.1:34350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-09-19T00:59:50.957347Z","caller":"traceutil/trace.go:171","msg":"trace[1651994549] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"129.527577ms","start":"2026-09-19T00:59:50.827789Z","end":"2026-09-19T00:59:50.957317Z","steps":["trace[1651994549] 'read index received' (duration: 63.271134ms)","trace[1651994549] 'applied index is now lower than readState.Index' (duration: 66.254793ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T00:59:50.9576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.807101ms","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-19T00:59:50.957643Z","caller":"traceutil/trace.go:171","msg":"trace[1620594085] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2133; }","duration":"129.872421ms","start":"2026-09-19T00:59:50.827759Z","end":"2026-09-19T00:59:50.957632Z","steps":["trace[1620594085] 'agreement among raft nodes before linearized reading' (duration: 129.76237ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T00:59:50.957683Z","caller":"traceutil/trace.go:171","msg":"trace[1393220330] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"136.749512ms","start":"2026-09-19T00:59:50.820911Z","end":"2026-09-19T00:59:50.95766Z","steps":["trace[1393220330] 'process raft request' (duration: 70.129254ms)","trace[1393220330] 'compare' (duration: 65.989711ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T00:59:51.351189Z","caller":"traceutil/trace.go:171","msg":"trace[1198009727] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"389.417057ms","start":"2026-09-19T00:59:50.961744Z","end":"2026-09-19T00:59:51.351161Z","steps":["trace[1198009727] 'process raft request' (duration: 389.268205ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:59:51.351552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:59:50.961727Z","time spent":"389.62527ms","remote":"127.0.0.1:42704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T00:59:51.371421Z","caller":"traceutil/trace.go:171","msg":"trace[453272531] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"409.652794ms","start":"2026-09-19T00:59:50.961747Z","end":"2026-09-19T00:59:51.3714Z","steps":["trace[453272531] 'process raft request' (duration: 409.515652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T00:59:51.371615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T00:59:50.961719Z","time spent":"409.769686ms","remote":"127.0.0.1:42704","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:00:20.682254Z","caller":"traceutil/trace.go:171","msg":"trace[1648894691] linearizableReadLoop","detail":"{readStateIndex:2382; appliedIndex:2378; }","duration":"101.521078ms","start":"2026-09-19T01:00:20.58071Z","end":"2026-09-19T01:00:20.682231Z","steps":["trace[1648894691] 'read index received' (duration: 9.825249ms)","trace[1648894691] 'applied index is now lower than readState.Index' (duration: 91.694909ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:00:20.682518Z","caller":"traceutil/trace.go:171","msg":"trace[486652840] transaction","detail":"{read_only:false; response_revision:2296; number_of_response:1; }","duration":"108.163388ms","start":"2026-09-19T01:00:20.574329Z","end":"2026-09-19T01:00:20.682492Z","steps":["trace[486652840] 'process raft request' (duration: 107.785831ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:00:20.682574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.846413ms","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:00:20.682629Z","caller":"traceutil/trace.go:171","msg":"trace[1953774818] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2297; }","duration":"101.941368ms","start":"2026-09-19T01:00:20.580672Z","end":"2026-09-19T01:00:20.682614Z","steps":["trace[1953774818] 'agreement among raft nodes before linearized reading' (duration: 101.645423ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:00:20.682783Z","caller":"traceutil/trace.go:171","msg":"trace[971365696] transaction","detail":"{read_only:false; response_revision:2294; number_of_response:1; }","duration":"109.297051ms","start":"2026-09-19T01:00:20.573449Z","end":"2026-09-19T01:00:20.682746Z","steps":["trace[971365696] 'process raft request' (duration: 80.451034ms)","trace[971365696] 'compare' (duration: 27.968156ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:00:20.683075Z","caller":"traceutil/trace.go:171","msg":"trace[106119884] transaction","detail":"{read_only:false; response_revision:2295; number_of_response:1; }","duration":"108.953366ms","start":"2026-09-19T01:00:20.574091Z","end":"2026-09-19T01:00:20.683044Z","steps":["trace[106119884] 'process raft request' (duration: 107.968399ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:00:56.080049Z","caller":"traceutil/trace.go:171","msg":"trace[579295324] linearizableReadLoop","detail":"{readStateIndex:2680; appliedIndex:2679; }","duration":"102.605866ms","start":"2026-09-19T01:00:55.977419Z","end":"2026-09-19T01:00:56.080025Z","steps":["trace[579295324] 'read index received' (duration: 102.464021ms)","trace[579295324] 'applied index is now lower than readState.Index' (duration: 140.585µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:00:56.080138Z","caller":"traceutil/trace.go:171","msg":"trace[267279718] transaction","detail":"{read_only:false; response_revision:2586; number_of_response:1; }","duration":"211.285896ms","start":"2026-09-19T01:00:55.868816Z","end":"2026-09-19T01:00:56.080102Z","steps":["trace[267279718] 'process raft request' (duration: 211.035777ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:00:56.080326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.901109ms","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:00:56.080388Z","caller":"traceutil/trace.go:171","msg":"trace[1744575834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2586; }","duration":"103.014213ms","start":"2026-09-19T01:00:55.97736Z","end":"2026-09-19T01:00:56.080374Z","steps":["trace[1744575834] 'agreement among raft nodes before linearized reading' (duration: 102.777243ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:00:56.257917Z","caller":"traceutil/trace.go:171","msg":"trace[1097811310] transaction","detail":"{read_only:false; response_revision:2587; number_of_response:1; }","duration":"173.073318ms","start":"2026-09-19T01:00:56.084816Z","end":"2026-09-19T01:00:56.257889Z","steps":["trace[1097811310] 'process raft request' (duration: 172.86221ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:00:56.259717Z","caller":"traceutil/trace.go:171","msg":"trace[1280479712] transaction","detail":"{read_only:false; response_revision:2588; number_of_response:1; }","duration":"174.811987ms","start":"2026-09-19T01:00:56.084886Z","end":"2026-09-19T01:00:56.259698Z","steps":["trace[1280479712] 'process raft request' (duration: 174.676792ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:00:56.259718Z","caller":"traceutil/trace.go:171","msg":"trace[1019177361] transaction","detail":"{read_only:false; response_revision:2589; number_of_response:1; }","duration":"174.814827ms","start":"2026-09-19T01:00:56.084886Z","end":"2026-09-19T01:00:56.259701Z","steps":["trace[1019177361] 'process raft request' (duration: 174.773945ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:52.639207Z","caller":"traceutil/trace.go:171","msg":"trace[1396688477] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"127.22553ms","start":"2026-09-19T01:05:52.511951Z","end":"2026-09-19T01:05:52.639177Z","steps":["trace[1396688477] 'process raft request' (duration: 127.077978ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:52.774722Z","caller":"traceutil/trace.go:171","msg":"trace[1474750007] linearizableReadLoop","detail":"{readStateIndex:4957; appliedIndex:4956; }","duration":"126.564979ms","start":"2026-09-19T01:05:52.648121Z","end":"2026-09-19T01:05:52.774686Z","steps":["trace[1474750007] 'read index received' (duration: 126.16965ms)","trace[1474750007] 'applied index is now lower than readState.Index' (duration: 394.129µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:05:52.775042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.915855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:122003"} {"level":"info","ts":"2026-09-19T01:05:52.77509Z","caller":"traceutil/trace.go:171","msg":"trace[1113163260] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:4778; }","duration":"127.005887ms","start":"2026-09-19T01:05:52.648072Z","end":"2026-09-19T01:05:52.775078Z","steps":["trace[1113163260] 'agreement among raft nodes before linearized reading' (duration: 126.755302ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:52.77561Z","caller":"traceutil/trace.go:171","msg":"trace[862302033] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"127.893023ms","start":"2026-09-19T01:05:52.6477Z","end":"2026-09-19T01:05:52.775593Z","steps":["trace[862302033] 'process raft request' (duration: 126.71266ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:54.600692Z","caller":"traceutil/trace.go:171","msg":"trace[969609983] linearizableReadLoop","detail":"{readStateIndex:5008; appliedIndex:5006; }","duration":"115.425699ms","start":"2026-09-19T01:05:54.485236Z","end":"2026-09-19T01:05:54.600662Z","steps":["trace[969609983] 'read index received' (duration: 77.413189ms)","trace[969609983] 'applied index is now lower than readState.Index' (duration: 38.01179ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:05:54.600928Z","caller":"traceutil/trace.go:171","msg":"trace[1529164378] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"139.872289ms","start":"2026-09-19T01:05:54.461041Z","end":"2026-09-19T01:05:54.600913Z","steps":["trace[1529164378] 'process raft request' (duration: 101.594934ms)","trace[1529164378] 'compare' (duration: 37.842367ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:05:54.601138Z","caller":"traceutil/trace.go:171","msg":"trace[234696478] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"139.637245ms","start":"2026-09-19T01:05:54.46143Z","end":"2026-09-19T01:05:54.601067Z","steps":["trace[234696478] 'process raft request' (duration: 139.181846ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:05:54.601849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.129003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-ksgr2\" ","response":"range_response_count:1 size:4819"} {"level":"info","ts":"2026-09-19T01:05:54.60192Z","caller":"traceutil/trace.go:171","msg":"trace[616020322] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-ksgr2; range_end:; response_count:1; response_revision:4826; }","duration":"116.716164ms","start":"2026-09-19T01:05:54.48519Z","end":"2026-09-19T01:05:54.601906Z","steps":["trace[616020322] 'agreement among raft nodes before linearized reading' (duration: 115.580942ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:56.825001Z","caller":"traceutil/trace.go:171","msg":"trace[305153240] linearizableReadLoop","detail":"{readStateIndex:5062; appliedIndex:5061; }","duration":"115.063658ms","start":"2026-09-19T01:05:56.709911Z","end":"2026-09-19T01:05:56.824975Z","steps":["trace[305153240] 'read index received' (duration: 99.219935ms)","trace[305153240] 'applied index is now lower than readState.Index' (duration: 15.841103ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:05:56.82509Z","caller":"traceutil/trace.go:171","msg":"trace[2036364348] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"148.333848ms","start":"2026-09-19T01:05:56.676718Z","end":"2026-09-19T01:05:56.825052Z","steps":["trace[2036364348] 'process raft request' (duration: 132.476644ms)","trace[2036364348] 'compare' (duration: 15.478557ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:05:56.825147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.204661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-8hdsj-tls\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:05:56.825191Z","caller":"traceutil/trace.go:171","msg":"trace[1787901962] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-8hdsj-tls; range_end:; response_count:0; response_revision:4879; }","duration":"115.298082ms","start":"2026-09-19T01:05:56.709876Z","end":"2026-09-19T01:05:56.825174Z","steps":["trace[1787901962] 'agreement among raft nodes before linearized reading' (duration: 115.20225ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:56.995739Z","caller":"traceutil/trace.go:171","msg":"trace[1560237995] linearizableReadLoop","detail":"{readStateIndex:5065; appliedIndex:5063; }","duration":"112.113472ms","start":"2026-09-19T01:05:56.883592Z","end":"2026-09-19T01:05:56.995706Z","steps":["trace[1560237995] 'read index received' (duration: 77.628031ms)","trace[1560237995] 'applied index is now lower than readState.Index' (duration: 34.483981ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:05:56.995784Z","caller":"traceutil/trace.go:171","msg":"trace[1831392937] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4881; }","duration":"115.13546ms","start":"2026-09-19T01:05:56.880619Z","end":"2026-09-19T01:05:56.995754Z","steps":["trace[1831392937] 'process raft request' (duration: 114.925536ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:05:56.996215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.530971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-19T01:05:56.996356Z","caller":"traceutil/trace.go:171","msg":"trace[659896548] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4881; }","duration":"112.785375ms","start":"2026-09-19T01:05:56.883549Z","end":"2026-09-19T01:05:56.996335Z","steps":["trace[659896548] 'agreement among raft nodes before linearized reading' (duration: 112.271634ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:05:57.015083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.54062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-09-19T01:05:57.015155Z","caller":"traceutil/trace.go:171","msg":"trace[1465042722] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4882; }","duration":"124.622542ms","start":"2026-09-19T01:05:56.890517Z","end":"2026-09-19T01:05:57.015139Z","steps":["trace[1465042722] 'agreement among raft nodes before linearized reading' (duration: 124.451209ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:57.135567Z","caller":"traceutil/trace.go:171","msg":"trace[1169663503] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"101.669989ms","start":"2026-09-19T01:05:57.033875Z","end":"2026-09-19T01:05:57.135545Z","steps":["trace[1169663503] 'process raft request' (duration: 101.564437ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:57.135602Z","caller":"traceutil/trace.go:171","msg":"trace[1410487050] linearizableReadLoop","detail":"{readStateIndex:5067; appliedIndex:5067; }","duration":"100.587919ms","start":"2026-09-19T01:05:57.034985Z","end":"2026-09-19T01:05:57.135573Z","steps":["trace[1410487050] 'read index received' (duration: 100.575679ms)","trace[1410487050] 'applied index is now lower than readState.Index' (duration: 9.9µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:05:57.13587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.863864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-09-19T01:05:57.13591Z","caller":"traceutil/trace.go:171","msg":"trace[127619373] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4883; }","duration":"100.969206ms","start":"2026-09-19T01:05:57.034924Z","end":"2026-09-19T01:05:57.135893Z","steps":["trace[127619373] 'agreement among raft nodes before linearized reading' (duration: 100.787023ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:02.616546Z","caller":"traceutil/trace.go:171","msg":"trace[1610452826] linearizableReadLoop","detail":"{readStateIndex:5167; appliedIndex:5166; }","duration":"121.418598ms","start":"2026-09-19T01:06:02.495102Z","end":"2026-09-19T01:06:02.616521Z","steps":["trace[1610452826] 'read index received' (duration: 121.270246ms)","trace[1610452826] 'applied index is now lower than readState.Index' (duration: 147.292µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:06:02.616594Z","caller":"traceutil/trace.go:171","msg":"trace[21155287] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"179.443676ms","start":"2026-09-19T01:06:02.437127Z","end":"2026-09-19T01:06:02.616571Z","steps":["trace[21155287] 'process raft request' (duration: 179.262703ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:02.616711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.585881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:06:02.616752Z","caller":"traceutil/trace.go:171","msg":"trace[2043038402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4981; }","duration":"121.691193ms","start":"2026-09-19T01:06:02.495048Z","end":"2026-09-19T01:06:02.616739Z","steps":["trace[2043038402] 'agreement among raft nodes before linearized reading' (duration: 121.597162ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:02.891632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.358964ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:06:02.891777Z","caller":"traceutil/trace.go:171","msg":"trace[1256640006] linearizableReadLoop","detail":"{readStateIndex:5168; appliedIndex:5167; }","duration":"275.121243ms","start":"2026-09-19T01:06:02.616626Z","end":"2026-09-19T01:06:02.891748Z","steps":["trace[1256640006] 'read index received' (duration: 117.499534ms)","trace[1256640006] 'applied index is now lower than readState.Index' (duration: 157.619599ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:06:02.892111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.205817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:06:02.892171Z","caller":"traceutil/trace.go:171","msg":"trace[1820253867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4982; }","duration":"274.307268ms","start":"2026-09-19T01:06:02.617844Z","end":"2026-09-19T01:06:02.892151Z","steps":["trace[1820253867] 'agreement among raft nodes before linearized reading' (duration: 274.173845ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:02.892322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.437514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-091103a3-7191-488f-aa0b-139424ec0b4e\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-19T01:06:02.89238Z","caller":"traceutil/trace.go:171","msg":"trace[70260996] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-091103a3-7191-488f-aa0b-139424ec0b4e; range_end:; response_count:1; response_revision:4982; }","duration":"248.528667ms","start":"2026-09-19T01:06:02.643837Z","end":"2026-09-19T01:06:02.892366Z","steps":["trace[70260996] 'agreement among raft nodes before linearized reading' (duration: 248.257652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:02.892355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.920091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-091103a3-7191-488f-aa0b-139424ec0b4e\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-19T01:06:02.892507Z","caller":"traceutil/trace.go:171","msg":"trace[1263460159] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"345.433996ms","start":"2026-09-19T01:06:02.546386Z","end":"2026-09-19T01:06:02.89182Z","steps":["trace[1263460159] 'process raft request' (duration: 187.791126ms)","trace[1263460159] 'compare' (duration: 157.202762ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:06:02.892582Z","caller":"traceutil/trace.go:171","msg":"trace[43963991] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-091103a3-7191-488f-aa0b-139424ec0b4e; range_end:; response_count:1; response_revision:4982; }","duration":"351.302768ms","start":"2026-09-19T01:06:02.541156Z","end":"2026-09-19T01:06:02.892459Z","steps":["trace[43963991] 'agreement among raft nodes before linearized reading' (duration: 350.808718ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:02.892785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:06:02.541133Z","time spent":"351.632304ms","remote":"127.0.0.1:42618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-091103a3-7191-488f-aa0b-139424ec0b4e\" "} {"level":"warn","ts":"2026-09-19T01:06:02.893271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:06:02.546359Z","time spent":"346.291632ms","remote":"127.0.0.1:42494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":878,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T01:06:03.337318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.442299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:06:03.337503Z","caller":"traceutil/trace.go:171","msg":"trace[1813963331] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4987; }","duration":"174.638863ms","start":"2026-09-19T01:06:03.162842Z","end":"2026-09-19T01:06:03.337481Z","steps":["trace[1813963331] 'range keys from in-memory index tree' (duration: 174.379618ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:03.337942Z","caller":"traceutil/trace.go:171","msg":"trace[675188657] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"141.423799ms","start":"2026-09-19T01:06:03.196497Z","end":"2026-09-19T01:06:03.33792Z","steps":["trace[675188657] 'process raft request' (duration: 43.307667ms)","trace[675188657] 'compare' (duration: 97.759305ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:06:17.721256Z","caller":"traceutil/trace.go:171","msg":"trace[40981528] linearizableReadLoop","detail":"{readStateIndex:5368; appliedIndex:5367; }","duration":"170.338424ms","start":"2026-09-19T01:06:17.550884Z","end":"2026-09-19T01:06:17.721223Z","steps":["trace[40981528] 'read index received' (duration: 170.07906ms)","trace[40981528] 'applied index is now lower than readState.Index' (duration: 258.084µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:06:17.721391Z","caller":"traceutil/trace.go:171","msg":"trace[350151459] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"392.886765ms","start":"2026-09-19T01:06:17.328462Z","end":"2026-09-19T01:06:17.721349Z","steps":["trace[350151459] 'process raft request' (duration: 392.543598ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:17.721531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.62997ms","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:06:17.721581Z","caller":"traceutil/trace.go:171","msg":"trace[272100810] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5177; }","duration":"170.736402ms","start":"2026-09-19T01:06:17.550829Z","end":"2026-09-19T01:06:17.721566Z","steps":["trace[272100810] 'agreement among raft nodes before linearized reading' (duration: 170.548868ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:17.721588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:06:17.328428Z","time spent":"393.048408ms","remote":"127.0.0.1:42704","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:06:17.793026Z","caller":"traceutil/trace.go:171","msg":"trace[582938825] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"214.187443ms","start":"2026-09-19T01:06:17.578802Z","end":"2026-09-19T01:06:17.79299Z","steps":["trace[582938825] 'process raft request' (duration: 203.726886ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:17.793302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.082435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-19T01:06:17.79465Z","caller":"traceutil/trace.go:171","msg":"trace[522807161] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5179; }","duration":"211.490091ms","start":"2026-09-19T01:06:17.583145Z","end":"2026-09-19T01:06:17.794635Z","steps":["trace[522807161] 'agreement among raft nodes before linearized reading' (duration: 210.002113ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:18.002139Z","caller":"traceutil/trace.go:171","msg":"trace[781295924] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"101.582687ms","start":"2026-09-19T01:06:17.900492Z","end":"2026-09-19T01:06:18.002075Z","steps":["trace[781295924] 'process raft request' (duration: 101.412164ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:18.136598Z","caller":"traceutil/trace.go:171","msg":"trace[678624607] transaction","detail":"{read_only:false; response_revision:5184; number_of_response:1; }","duration":"125.835672ms","start":"2026-09-19T01:06:18.010714Z","end":"2026-09-19T01:06:18.13655Z","steps":["trace[678624607] 'process raft request' (duration: 112.825346ms)","trace[678624607] 'compare' (duration: 12.741051ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:06:18.163268Z","caller":"traceutil/trace.go:171","msg":"trace[395742277] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"152.19551ms","start":"2026-09-19T01:06:18.01103Z","end":"2026-09-19T01:06:18.163226Z","steps":["trace[395742277] 'process raft request' (duration: 151.901404ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:18.163332Z","caller":"traceutil/trace.go:171","msg":"trace[671654210] transaction","detail":"{read_only:false; response_revision:5186; number_of_response:1; }","duration":"152.17463ms","start":"2026-09-19T01:06:18.011136Z","end":"2026-09-19T01:06:18.163311Z","steps":["trace[671654210] 'process raft request' (duration: 151.993316ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:18.163271Z","caller":"traceutil/trace.go:171","msg":"trace[1611703051] transaction","detail":"{read_only:false; response_revision:5187; number_of_response:1; }","duration":"152.092128ms","start":"2026-09-19T01:06:18.011148Z","end":"2026-09-19T01:06:18.16324Z","steps":["trace[1611703051] 'process raft request' (duration: 152.039977ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:51.176502Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2887} {"level":"info","ts":"2026-09-19T01:06:51.336865Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2887,"took":"159.375811ms","hash":2618916390,"current-db-size-bytes":51539968,"current-db-size":"52 MB","current-db-size-in-use-bytes":27774976,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-19T01:06:51.337121Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2618916390,"revision":2887,"compact-revision":-1} {"level":"info","ts":"2026-09-19T01:06:55.142495Z","caller":"traceutil/trace.go:171","msg":"trace[499359212] transaction","detail":"{read_only:false; response_revision:5500; number_of_response:1; }","duration":"113.376237ms","start":"2026-09-19T01:06:55.029095Z","end":"2026-09-19T01:06:55.142471Z","steps":["trace[499359212] 'process raft request' (duration: 113.261775ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:03.856262Z","caller":"traceutil/trace.go:171","msg":"trace[159214053] linearizableReadLoop","detail":"{readStateIndex:5752; appliedIndex:5751; }","duration":"107.244865ms","start":"2026-09-19T01:07:03.74899Z","end":"2026-09-19T01:07:03.856235Z","steps":["trace[159214053] 'read index received' (duration: 106.99366ms)","trace[159214053] 'applied index is now lower than readState.Index' (duration: 250.445µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:07:03.85639Z","caller":"traceutil/trace.go:171","msg":"trace[428180790] transaction","detail":"{read_only:false; response_revision:5550; number_of_response:1; }","duration":"115.665019ms","start":"2026-09-19T01:07:03.740706Z","end":"2026-09-19T01:07:03.856371Z","steps":["trace[428180790] 'process raft request' (duration: 115.316693ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:07:03.856555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.514839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T01:07:03.856637Z","caller":"traceutil/trace.go:171","msg":"trace[98110539] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5550; }","duration":"107.676323ms","start":"2026-09-19T01:07:03.748947Z","end":"2026-09-19T01:07:03.856623Z","steps":["trace[98110539] 'agreement among raft nodes before linearized reading' (duration: 107.448368ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:07:12.263622Z","caller":"traceutil/trace.go:171","msg":"trace[556968061] linearizableReadLoop","detail":"{readStateIndex:5820; appliedIndex:5819; }","duration":"117.662127ms","start":"2026-09-19T01:07:12.145926Z","end":"2026-09-19T01:07:12.263588Z","steps":["trace[556968061] 'read index received' (duration: 117.334301ms)","trace[556968061] 'applied index is now lower than readState.Index' (duration: 326.646µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:07:12.263696Z","caller":"traceutil/trace.go:171","msg":"trace[2056976550] transaction","detail":"{read_only:false; response_revision:5615; number_of_response:1; }","duration":"137.847754ms","start":"2026-09-19T01:07:12.125821Z","end":"2026-09-19T01:07:12.263669Z","steps":["trace[2056976550] 'process raft request' (duration: 137.497828ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:07:12.263816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.8708ms","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-19T01:07:12.263863Z","caller":"traceutil/trace.go:171","msg":"trace[1448838359] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5615; }","duration":"117.984452ms","start":"2026-09-19T01:07:12.145862Z","end":"2026-09-19T01:07:12.263846Z","steps":["trace[1448838359] 'agreement among raft nodes before linearized reading' (duration: 117.86717ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:07:12.26396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.962092ms","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-19T01:07:12.264079Z","caller":"traceutil/trace.go:171","msg":"trace[123079594] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5615; }","duration":"118.181036ms","start":"2026-09-19T01:07:12.145869Z","end":"2026-09-19T01:07:12.26405Z","steps":["trace[123079594] 'agreement among raft nodes before linearized reading' (duration: 117.934881ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:07:12.264096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.832238ms","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:07:12.264216Z","caller":"traceutil/trace.go:171","msg":"trace[249824671] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5615; }","duration":"112.94415ms","start":"2026-09-19T01:07:12.151221Z","end":"2026-09-19T01:07:12.264166Z","steps":["trace[249824671] 'agreement among raft nodes before linearized reading' (duration: 112.647455ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:09:56.167175Z","caller":"traceutil/trace.go:171","msg":"trace[750956482] transaction","detail":"{read_only:false; response_revision:6760; number_of_response:1; }","duration":"132.276083ms","start":"2026-09-19T01:09:56.034876Z","end":"2026-09-19T01:09:56.167152Z","steps":["trace[750956482] 'process raft request' (duration: 132.132748ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:10:07.128468Z","caller":"traceutil/trace.go:171","msg":"trace[1343873997] transaction","detail":"{read_only:false; response_revision:6817; number_of_response:1; }","duration":"139.419857ms","start":"2026-09-19T01:10:06.989021Z","end":"2026-09-19T01:10:07.12844Z","steps":["trace[1343873997] 'process raft request' (duration: 139.281472ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:10:12.890341Z","caller":"traceutil/trace.go:171","msg":"trace[2097125806] transaction","detail":"{read_only:false; response_revision:6858; number_of_response:1; }","duration":"100.793251ms","start":"2026-09-19T01:10:12.789529Z","end":"2026-09-19T01:10:12.890322Z","steps":["trace[2097125806] 'process raft request' (duration: 100.331595ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:11:51.192949Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5385} {"level":"info","ts":"2026-09-19T01:11:51.2774Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5385,"took":"83.448418ms","hash":575423269,"current-db-size-bytes":51539968,"current-db-size":"52 MB","current-db-size-in-use-bytes":18612224,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-19T01:11:51.277469Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":575423269,"revision":5385,"compact-revision":2887}