{"level":"warn","ts":"2026-10-15T18:56:18.466593Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-15T18:56:18.466714Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.214: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.214:2380","--initial-cluster=instance=https://162.253.55.214:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.214:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.214: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-10-15T18:56:18.46681Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-15T18:56:18.466827Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.214:2380"]}
{"level":"info","ts":"2026-10-15T18:56:18.466852Z","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-10-15T18:56:18.475521Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"]}
{"level":"info","ts":"2026-10-15T18:56:18.475662Z","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.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.214: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-10-15T18:56:18.47898Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.917514ms"}
{"level":"info","ts":"2026-10-15T18:56:18.486875Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"86f12f2ae020828","cluster-id":"dfe59afaaa064e4a"}
{"level":"info","ts":"2026-10-15T18:56:18.486965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-15T18:56:18.486998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 0"}
{"level":"info","ts":"2026-10-15T18:56:18.487029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 86f12f2ae020828 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-15T18:56:18.487037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 1"}
{"level":"info","ts":"2026-10-15T18:56:18.487075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"}
{"level":"warn","ts":"2026-10-15T18:56:18.497923Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-15T18:56:18.499519Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-15T18:56:18.500814Z","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-10-15T18:56:18.502923Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"86f12f2ae020828","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-15T18:56:18.50324Z","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-10-15T18:56:18.503335Z","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-10-15T18:56:18.503372Z","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-10-15T18:56:18.504889Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"86f12f2ae020828","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-15T18:56:18.506397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"}
{"level":"info","ts":"2026-10-15T18:56:18.506532Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","added-peer-id":"86f12f2ae020828","added-peer-peer-urls":["https://162.253.55.214:2380"]}
{"level":"info","ts":"2026-10-15T18:56:18.50722Z","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-10-15T18:56:18.507478Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"86f12f2ae020828","initial-advertise-peer-urls":["https://162.253.55.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-15T18:56:18.507507Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-15T18:56:18.50763Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.214:2380"}
{"level":"info","ts":"2026-10-15T18:56:18.507643Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.214:2380"}
{"level":"info","ts":"2026-10-15T18:56:19.2908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-15T18:56:19.29091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-15T18:56:19.290953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgPreVoteResp from 86f12f2ae020828 at term 1"}
{"level":"info","ts":"2026-10-15T18:56:19.290976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became candidate at term 2"}
{"level":"info","ts":"2026-10-15T18:56:19.290987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgVoteResp from 86f12f2ae020828 at term 2"}
{"level":"info","ts":"2026-10-15T18:56:19.291004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became leader at term 2"}
{"level":"info","ts":"2026-10-15T18:56:19.291041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 86f12f2ae020828 elected leader 86f12f2ae020828 at term 2"}
{"level":"info","ts":"2026-10-15T18:56:19.295161Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-15T18:56:19.295416Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-15T18:56:19.295415Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"86f12f2ae020828","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.214:2379]}","request-path":"/0/members/86f12f2ae020828/attributes","cluster-id":"dfe59afaaa064e4a","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-15T18:56:19.295486Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-15T18:56:19.29584Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-15T18:56:19.295862Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-15T18:56:19.296285Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-15T18:56:19.296532Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-15T18:56:19.297195Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-15T18:56:19.298791Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.214:2379"}
{"level":"info","ts":"2026-10-15T18:56:19.300933Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-15T18:56:21.327405Z","caller":"traceutil/trace.go:171","msg":"trace[589243258] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"122.515839ms","start":"2026-10-15T18:56:21.204852Z","end":"2026-10-15T18:56:21.327368Z","steps":["trace[589243258] 'process raft request'  (duration: 122.317144ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:21.327526Z","caller":"traceutil/trace.go:171","msg":"trace[1148188383] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"122.034766ms","start":"2026-10-15T18:56:21.205435Z","end":"2026-10-15T18:56:21.32747Z","steps":["trace[1148188383] 'process raft request'  (duration: 121.884782ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:21.327576Z","caller":"traceutil/trace.go:171","msg":"trace[1964572593] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"120.873119ms","start":"2026-10-15T18:56:21.206652Z","end":"2026-10-15T18:56:21.327525Z","steps":["trace[1964572593] 'process raft request'  (duration: 120.826897ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:21.3282Z","caller":"traceutil/trace.go:171","msg":"trace[737696035] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"121.799381ms","start":"2026-10-15T18:56:21.206379Z","end":"2026-10-15T18:56:21.328179Z","steps":["trace[737696035] 'process raft request'  (duration: 121.029402ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:21.328243Z","caller":"traceutil/trace.go:171","msg":"trace[2130006798] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"121.894044ms","start":"2026-10-15T18:56:21.206328Z","end":"2026-10-15T18:56:21.328222Z","steps":["trace[2130006798] 'process raft request'  (duration: 121.035352ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:21.32834Z","caller":"traceutil/trace.go:171","msg":"trace[2026814576] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"121.884853ms","start":"2026-10-15T18:56:21.206417Z","end":"2026-10-15T18:56:21.328302Z","steps":["trace[2026814576] 'process raft request'  (duration: 121.035812ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:21.357214Z","caller":"traceutil/trace.go:171","msg":"trace[1959891640] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:33; }","duration":"114.762056ms","start":"2026-10-15T18:56:21.242427Z","end":"2026-10-15T18:56:21.35719Z","steps":["trace[1959891640] 'read index received'  (duration: 84.808416ms)","trace[1959891640] 'applied index is now lower than readState.Index'  (duration: 29.95261ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:56:21.357342Z","caller":"traceutil/trace.go:171","msg":"trace[623419339] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"141.051246ms","start":"2026-10-15T18:56:21.216283Z","end":"2026-10-15T18:56:21.357334Z","steps":["trace[623419339] 'process raft request'  (duration: 140.862011ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:21.357292Z","caller":"traceutil/trace.go:171","msg":"trace[196870799] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"142.80762ms","start":"2026-10-15T18:56:21.214465Z","end":"2026-10-15T18:56:21.357273Z","steps":["trace[196870799] 'process raft request'  (duration: 142.613996ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:21.357532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.053894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-10-15T18:56:21.357648Z","caller":"traceutil/trace.go:171","msg":"trace[1307488661] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:37; }","duration":"115.260359ms","start":"2026-10-15T18:56:21.242358Z","end":"2026-10-15T18:56:21.357619Z","steps":["trace[1307488661] 'agreement among raft nodes before linearized reading'  (duration: 114.976262ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:24.392871Z","caller":"traceutil/trace.go:171","msg":"trace[1364000838] linearizableReadLoop","detail":"{readStateIndex:265; appliedIndex:264; }","duration":"128.241608ms","start":"2026-10-15T18:56:24.264592Z","end":"2026-10-15T18:56:24.392834Z","steps":["trace[1364000838] 'read index received'  (duration: 128.138896ms)","trace[1364000838] 'applied index is now lower than readState.Index'  (duration: 101.652µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:56:24.393179Z","caller":"traceutil/trace.go:171","msg":"trace[1563224824] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"158.295582ms","start":"2026-10-15T18:56:24.23487Z","end":"2026-10-15T18:56:24.393165Z","steps":["trace[1563224824] 'process raft request'  (duration: 157.739558ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:24.393453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.820212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T18:56:24.393493Z","caller":"traceutil/trace.go:171","msg":"trace[291936363] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:259; }","duration":"128.917205ms","start":"2026-10-15T18:56:24.26456Z","end":"2026-10-15T18:56:24.393477Z","steps":["trace[291936363] 'agreement among raft nodes before linearized reading'  (duration: 128.786812ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:24.789294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.541702ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897051583232840 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/instance.18dec8e43e24a35a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18dec8e43e24a35a\" value_size:524 lease:587897051583232438 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-10-15T18:56:24.789426Z","caller":"traceutil/trace.go:171","msg":"trace[73641648] linearizableReadLoop","detail":"{readStateIndex:266; appliedIndex:265; }","duration":"396.451689ms","start":"2026-10-15T18:56:24.392956Z","end":"2026-10-15T18:56:24.789408Z","steps":["trace[73641648] 'read index received'  (duration: 201.286883ms)","trace[73641648] 'applied index is now lower than readState.Index'  (duration: 195.161836ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T18:56:24.789573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.791197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T18:56:24.789669Z","caller":"traceutil/trace.go:171","msg":"trace[2012146457] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:260; }","duration":"411.939071ms","start":"2026-10-15T18:56:24.377705Z","end":"2026-10-15T18:56:24.789645Z","steps":["trace[2012146457] 'agreement among raft nodes before linearized reading'  (duration: 411.726485ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:24.789644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.450182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"}
{"level":"warn","ts":"2026-10-15T18:56:24.789721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.377667Z","time spent":"412.045033ms","remote":"127.0.0.1:56912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "}
{"level":"info","ts":"2026-10-15T18:56:24.789768Z","caller":"traceutil/trace.go:171","msg":"trace[1767248427] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:260; }","duration":"412.620647ms","start":"2026-10-15T18:56:24.377105Z","end":"2026-10-15T18:56:24.789725Z","steps":["trace[1767248427] 'agreement among raft nodes before linearized reading'  (duration: 412.378431ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:24.789845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.377077Z","time spent":"412.758889ms","remote":"127.0.0.1:57028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"info","ts":"2026-10-15T18:56:24.790055Z","caller":"traceutil/trace.go:171","msg":"trace[2066185528] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"413.59505ms","start":"2026-10-15T18:56:24.376412Z","end":"2026-10-15T18:56:24.790007Z","steps":["trace[2066185528] 'process raft request'  (duration: 217.79976ms)","trace[2066185528] 'compare'  (duration: 194.389057ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T18:56:24.790172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.376381Z","time spent":"413.728013ms","remote":"127.0.0.1:56718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.18dec8e43e24a35a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18dec8e43e24a35a\" value_size:524 lease:587897051583232438 >> failure:<>"}
{"level":"warn","ts":"2026-10-15T18:56:25.162833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.99634ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897051583232842 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3310 >> failure:<>>","response":"size:5"}
{"level":"info","ts":"2026-10-15T18:56:25.163173Z","caller":"traceutil/trace.go:171","msg":"trace[2027275799] transaction","detail":"{read_only:false; number_of_response:0; response_revision:260; }","duration":"692.660615ms","start":"2026-10-15T18:56:24.470477Z","end":"2026-10-15T18:56:25.163138Z","steps":["trace[2027275799] 'process raft request'  (duration: 481.239595ms)","trace[2027275799] 'compare'  (duration: 210.912927ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:56:25.163289Z","caller":"traceutil/trace.go:171","msg":"trace[723040758] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"657.764526ms","start":"2026-10-15T18:56:24.50547Z","end":"2026-10-15T18:56:25.163235Z","steps":["trace[723040758] 'process raft request'  (duration: 657.49698ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:25.163353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.470452Z","time spent":"692.807168ms","remote":"127.0.0.1:56810","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3310 >> failure:<>"}
{"level":"info","ts":"2026-10-15T18:56:25.163338Z","caller":"traceutil/trace.go:171","msg":"trace[138821490] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"657.145751ms","start":"2026-10-15T18:56:24.506117Z","end":"2026-10-15T18:56:25.163263Z","steps":["trace[138821490] 'process raft request'  (duration: 657.007017ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:25.163434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.506105Z","time spent":"657.286764ms","remote":"127.0.0.1:56812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:3401 >> failure:<>"}
{"level":"info","ts":"2026-10-15T18:56:25.163445Z","caller":"traceutil/trace.go:171","msg":"trace[1984709267] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"369.788231ms","start":"2026-10-15T18:56:24.793628Z","end":"2026-10-15T18:56:25.163417Z","steps":["trace[1984709267] 'process raft request'  (duration: 369.72119ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:25.163489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.505439Z","time spent":"657.956761ms","remote":"127.0.0.1:56812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:5824 >> failure:<>"}
{"level":"info","ts":"2026-10-15T18:56:25.163532Z","caller":"traceutil/trace.go:171","msg":"trace[21717332] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"656.349992ms","start":"2026-10-15T18:56:24.507151Z","end":"2026-10-15T18:56:25.163501Z","steps":["trace[21717332] 'process raft request'  (duration: 656.115827ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:25.16354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.793611Z","time spent":"369.889734ms","remote":"127.0.0.1:56718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.18dec8e43e6acd3a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18dec8e43e6acd3a\" value_size:557 lease:587897051583232438 >> failure:<>"}
{"level":"info","ts":"2026-10-15T18:56:25.163508Z","caller":"traceutil/trace.go:171","msg":"trace[1547310058] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"657.018208ms","start":"2026-10-15T18:56:24.506408Z","end":"2026-10-15T18:56:25.163426Z","steps":["trace[1547310058] 'process raft request'  (duration: 656.818523ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:25.163623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.507139Z","time spent":"656.441234ms","remote":"127.0.0.1:56812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5431 >> failure:<>"}
{"level":"info","ts":"2026-10-15T18:56:25.163648Z","caller":"traceutil/trace.go:171","msg":"trace[133035387] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"657.296585ms","start":"2026-10-15T18:56:24.506339Z","end":"2026-10-15T18:56:25.163636Z","steps":["trace[133035387] 'process raft request'  (duration: 656.841464ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:25.163557Z","caller":"traceutil/trace.go:171","msg":"trace[1818782272] linearizableReadLoop","detail":"{readStateIndex:272; appliedIndex:266; }","duration":"374.092806ms","start":"2026-10-15T18:56:24.789453Z","end":"2026-10-15T18:56:25.163546Z","steps":["trace[1818782272] 'read index received'  (duration: 162.280986ms)","trace[1818782272] 'applied index is now lower than readState.Index'  (duration: 211.809149ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T18:56:25.163694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.506332Z","time spent":"657.338716ms","remote":"127.0.0.1:56812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3917 >> failure:<>"}
{"level":"warn","ts":"2026-10-15T18:56:25.163692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.745893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-10-15T18:56:25.163692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.593529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T18:56:25.16373Z","caller":"traceutil/trace.go:171","msg":"trace[1081252154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:266; }","duration":"766.819204ms","start":"2026-10-15T18:56:24.3969Z","end":"2026-10-15T18:56:25.163719Z","steps":["trace[1081252154] 'agreement among raft nodes before linearized reading'  (duration: 766.67647ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:25.163733Z","caller":"traceutil/trace.go:171","msg":"trace[1798142916] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:0; response_revision:266; }","duration":"761.659631ms","start":"2026-10-15T18:56:24.402063Z","end":"2026-10-15T18:56:25.163723Z","steps":["trace[1798142916] 'agreement among raft nodes before linearized reading'  (duration: 761.587039ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:25.163763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.396881Z","time spent":"766.876126ms","remote":"127.0.0.1:56912","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-10-15T18:56:25.163766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.402053Z","time spent":"761.706782ms","remote":"127.0.0.1:56744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/kube-system/coredns\" "}
{"level":"warn","ts":"2026-10-15T18:56:25.163873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.793596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"}
{"level":"warn","ts":"2026-10-15T18:56:25.163873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.995156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T18:56:25.163914Z","caller":"traceutil/trace.go:171","msg":"trace[852353477] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:266; }","duration":"370.878258ms","start":"2026-10-15T18:56:24.793023Z","end":"2026-10-15T18:56:25.163901Z","steps":["trace[852353477] 'agreement among raft nodes before linearized reading'  (duration: 370.746955ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:56:25.163915Z","caller":"traceutil/trace.go:171","msg":"trace[403091816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:266; }","duration":"330.083248ms","start":"2026-10-15T18:56:24.833821Z","end":"2026-10-15T18:56:25.163904Z","steps":["trace[403091816] 'agreement among raft nodes before linearized reading'  (duration: 330.011636ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:25.163948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.833797Z","time spent":"330.14508ms","remote":"127.0.0.1:56912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-10-15T18:56:25.163948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.793001Z","time spent":"370.9402ms","remote":"127.0.0.1:56810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4040,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-10-15T18:56:25.163993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.919069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"}
{"level":"info","ts":"2026-10-15T18:56:25.164024Z","caller":"traceutil/trace.go:171","msg":"trace[409014294] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:266; }","duration":"371.002951ms","start":"2026-10-15T18:56:24.793012Z","end":"2026-10-15T18:56:25.164015Z","steps":["trace[409014294] 'agreement among raft nodes before linearized reading'  (duration: 370.95089ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:56:25.164053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.792994Z","time spent":"371.053733ms","remote":"127.0.0.1:57028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-10-15T18:56:25.163963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:56:24.506402Z","time spent":"657.305144ms","remote":"127.0.0.1:56812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>"}
{"level":"info","ts":"2026-10-15T18:57:02.184118Z","caller":"traceutil/trace.go:171","msg":"trace[1573101379] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"136.867063ms","start":"2026-10-15T18:57:02.047221Z","end":"2026-10-15T18:57:02.184088Z","steps":["trace[1573101379] 'process raft request'  (duration: 136.810972ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:57:02.184143Z","caller":"traceutil/trace.go:171","msg":"trace[898845700] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"136.983905ms","start":"2026-10-15T18:57:02.047105Z","end":"2026-10-15T18:57:02.184089Z","steps":["trace[898845700] 'process raft request'  (duration: 122.810628ms)","trace[898845700] 'compare'  (duration: 13.858221ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:57:03.979998Z","caller":"traceutil/trace.go:171","msg":"trace[761710983] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:557; }","duration":"105.542743ms","start":"2026-10-15T18:57:03.874418Z","end":"2026-10-15T18:57:03.979961Z","steps":["trace[761710983] 'read index received'  (duration: 105.180308ms)","trace[761710983] 'applied index is now lower than readState.Index'  (duration: 361.085µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T18:57:03.980173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.733347ms","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-10-15T18:57:03.980092Z","caller":"traceutil/trace.go:171","msg":"trace[1569888791] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"112.242488ms","start":"2026-10-15T18:57:03.86779Z","end":"2026-10-15T18:57:03.980032Z","steps":["trace[1569888791] 'process raft request'  (duration: 111.919644ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:57:03.980212Z","caller":"traceutil/trace.go:171","msg":"trace[1711145889] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:541; }","duration":"105.823628ms","start":"2026-10-15T18:57:03.874377Z","end":"2026-10-15T18:57:03.9802Z","steps":["trace[1711145889] 'agreement among raft nodes before linearized reading'  (duration: 105.713186ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:57:05.12782Z","caller":"traceutil/trace.go:171","msg":"trace[1851168880] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"136.258984ms","start":"2026-10-15T18:57:04.991534Z","end":"2026-10-15T18:57:05.127793Z","steps":["trace[1851168880] 'process raft request'  (duration: 79.245803ms)","trace[1851168880] 'compare'  (duration: 56.88476ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:57:10.820434Z","caller":"traceutil/trace.go:171","msg":"trace[1496390577] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"258.726428ms","start":"2026-10-15T18:57:10.561676Z","end":"2026-10-15T18:57:10.820402Z","steps":["trace[1496390577] 'process raft request'  (duration: 258.403713ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:57:11.167544Z","caller":"traceutil/trace.go:171","msg":"trace[1453216388] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"561.427981ms","start":"2026-10-15T18:57:10.60609Z","end":"2026-10-15T18:57:11.167518Z","steps":["trace[1453216388] 'process raft request'  (duration: 560.746729ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:57:11.167907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:57:10.606067Z","time spent":"561.579964ms","remote":"127.0.0.1:56736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:643 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036209 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-10-15T18:57:12.073602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.037671ms","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-10-15T18:57:12.07368Z","caller":"traceutil/trace.go:171","msg":"trace[2012618537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"471.182604ms","start":"2026-10-15T18:57:11.602479Z","end":"2026-10-15T18:57:12.073662Z","steps":["trace[2012618537] 'range keys from in-memory index tree'  (duration: 470.789157ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:57:12.073721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:57:11.602449Z","time spent":"471.260995ms","remote":"127.0.0.1:56912","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-10-15T18:57:12.073815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.472822ms","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-10-15T18:57:12.073938Z","caller":"traceutil/trace.go:171","msg":"trace[1980613577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:650; }","duration":"410.619424ms","start":"2026-10-15T18:57:11.663293Z","end":"2026-10-15T18:57:12.073912Z","steps":["trace[1980613577] 'range keys from in-memory index tree'  (duration: 409.889103ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:57:12.073983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:57:11.663233Z","time spent":"410.738846ms","remote":"127.0.0.1:56912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-10-15T18:57:12.077469Z","caller":"traceutil/trace.go:171","msg":"trace[1772499975] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"344.011205ms","start":"2026-10-15T18:57:11.73342Z","end":"2026-10-15T18:57:12.077431Z","steps":["trace[1772499975] 'process raft request'  (duration: 323.942949ms)","trace[1772499975] 'compare'  (duration: 18.192506ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T18:57:12.077816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T18:57:11.733386Z","time spent":"344.201308ms","remote":"127.0.0.1:56736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:649 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036229 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-10-15T18:57:56.201281Z","caller":"traceutil/trace.go:171","msg":"trace[805910003] linearizableReadLoop","detail":"{readStateIndex:1247; appliedIndex:1246; }","duration":"182.303212ms","start":"2026-10-15T18:57:56.018956Z","end":"2026-10-15T18:57:56.201259Z","steps":["trace[805910003] 'read index received'  (duration: 182.067289ms)","trace[805910003] 'applied index is now lower than readState.Index'  (duration: 235.123µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:57:56.201358Z","caller":"traceutil/trace.go:171","msg":"trace[1728617105] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"253.287295ms","start":"2026-10-15T18:57:55.948041Z","end":"2026-10-15T18:57:56.201328Z","steps":["trace[1728617105] 'process raft request'  (duration: 253.058292ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:57:56.201428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.457025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T18:57:56.201481Z","caller":"traceutil/trace.go:171","msg":"trace[1989755607] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1215; }","duration":"182.560506ms","start":"2026-10-15T18:57:56.018906Z","end":"2026-10-15T18:57:56.201467Z","steps":["trace[1989755607] 'agreement among raft nodes before linearized reading'  (duration: 182.456685ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:58:19.524Z","caller":"traceutil/trace.go:171","msg":"trace[1432944338] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"277.42605ms","start":"2026-10-15T18:58:19.246548Z","end":"2026-10-15T18:58:19.523974Z","steps":["trace[1432944338] 'process raft request'  (duration: 277.255278ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:58:45.770851Z","caller":"traceutil/trace.go:171","msg":"trace[379732499] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"118.89548ms","start":"2026-10-15T18:58:45.651928Z","end":"2026-10-15T18:58:45.770823Z","steps":["trace[379732499] 'process raft request'  (duration: 118.747949ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:58:59.238295Z","caller":"traceutil/trace.go:171","msg":"trace[409360474] linearizableReadLoop","detail":"{readStateIndex:2092; appliedIndex:2090; }","duration":"219.824828ms","start":"2026-10-15T18:58:59.018451Z","end":"2026-10-15T18:58:59.238276Z","steps":["trace[409360474] 'read index received'  (duration: 197.552071ms)","trace[409360474] 'applied index is now lower than readState.Index'  (duration: 22.272037ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:58:59.23842Z","caller":"traceutil/trace.go:171","msg":"trace[1196604716] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"295.650465ms","start":"2026-10-15T18:58:58.942758Z","end":"2026-10-15T18:58:59.238408Z","steps":["trace[1196604716] 'process raft request'  (duration: 273.212167ms)","trace[1196604716] 'compare'  (duration: 22.154815ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T18:58:59.238602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.137541ms","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-10-15T18:58:59.238654Z","caller":"traceutil/trace.go:171","msg":"trace[1147755221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2018; }","duration":"220.245053ms","start":"2026-10-15T18:58:59.018396Z","end":"2026-10-15T18:58:59.238641Z","steps":["trace[1147755221] 'agreement among raft nodes before linearized reading'  (duration: 220.054621ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:58:59.238882Z","caller":"traceutil/trace.go:171","msg":"trace[510076227] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"228.083735ms","start":"2026-10-15T18:58:59.010788Z","end":"2026-10-15T18:58:59.238872Z","steps":["trace[510076227] 'process raft request'  (duration: 227.440988ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:58:59.238913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.592956ms","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-10-15T18:58:59.238954Z","caller":"traceutil/trace.go:171","msg":"trace[2095304854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2018; }","duration":"219.654236ms","start":"2026-10-15T18:58:59.019286Z","end":"2026-10-15T18:58:59.238941Z","steps":["trace[2095304854] 'agreement among raft nodes before linearized reading'  (duration: 219.546955ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:58:59.239253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.369236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11982"}
{"level":"info","ts":"2026-10-15T18:58:59.239292Z","caller":"traceutil/trace.go:171","msg":"trace[2029094234] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2018; }","duration":"178.466527ms","start":"2026-10-15T18:58:59.060816Z","end":"2026-10-15T18:58:59.239282Z","steps":["trace[2029094234] 'agreement among raft nodes before linearized reading'  (duration: 178.361966ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:58:59.389673Z","caller":"traceutil/trace.go:171","msg":"trace[272188824] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"143.828799ms","start":"2026-10-15T18:58:59.245808Z","end":"2026-10-15T18:58:59.389637Z","steps":["trace[272188824] 'process raft request'  (duration: 126.033769ms)","trace[272188824] 'compare'  (duration: 17.593468ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:58:59.389699Z","caller":"traceutil/trace.go:171","msg":"trace[1645152512] linearizableReadLoop","detail":"{readStateIndex:2096; appliedIndex:2092; }","duration":"137.234628ms","start":"2026-10-15T18:58:59.252444Z","end":"2026-10-15T18:58:59.389679Z","steps":["trace[1645152512] 'read index received'  (duration: 71.059134ms)","trace[1645152512] 'applied index is now lower than readState.Index'  (duration: 66.174574ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:58:59.389831Z","caller":"traceutil/trace.go:171","msg":"trace[1705703697] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"143.92189ms","start":"2026-10-15T18:58:59.245887Z","end":"2026-10-15T18:58:59.389809Z","steps":["trace[1705703697] 'process raft request'  (duration: 143.655897ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:58:59.389876Z","caller":"traceutil/trace.go:171","msg":"trace[704219819] transaction","detail":"{read_only:false; response_revision:2022; number_of_response:1; }","duration":"140.979339ms","start":"2026-10-15T18:58:59.248881Z","end":"2026-10-15T18:58:59.389861Z","steps":["trace[704219819] 'process raft request'  (duration: 140.748217ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:58:59.389979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.525083ms","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-10-15T18:58:59.390019Z","caller":"traceutil/trace.go:171","msg":"trace[1333360282] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2022; }","duration":"137.610993ms","start":"2026-10-15T18:58:59.252397Z","end":"2026-10-15T18:58:59.390008Z","steps":["trace[1333360282] 'agreement among raft nodes before linearized reading'  (duration: 137.506042ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:58:59.390138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.656039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-10-15T18:58:59.390213Z","caller":"traceutil/trace.go:171","msg":"trace[1451316419] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2022; }","duration":"114.76197ms","start":"2026-10-15T18:58:59.275438Z","end":"2026-10-15T18:58:59.3902Z","steps":["trace[1451316419] 'agreement among raft nodes before linearized reading'  (duration: 114.563339ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:58:59.527862Z","caller":"traceutil/trace.go:171","msg":"trace[1996348121] linearizableReadLoop","detail":"{readStateIndex:2097; appliedIndex:2096; }","duration":"124.707835ms","start":"2026-10-15T18:58:59.403136Z","end":"2026-10-15T18:58:59.527844Z","steps":["trace[1996348121] 'read index received'  (duration: 86.858943ms)","trace[1996348121] 'applied index is now lower than readState.Index'  (duration: 37.847752ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:58:59.52793Z","caller":"traceutil/trace.go:171","msg":"trace[1986775264] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"128.491945ms","start":"2026-10-15T18:58:59.399407Z","end":"2026-10-15T18:58:59.527899Z","steps":["trace[1986775264] 'process raft request'  (duration: 90.704334ms)","trace[1986775264] 'compare'  (duration: 37.64699ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T18:58:59.528044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.935128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-10-15T18:58:59.528077Z","caller":"traceutil/trace.go:171","msg":"trace[1876596374] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2023; }","duration":"125.071519ms","start":"2026-10-15T18:58:59.402995Z","end":"2026-10-15T18:58:59.528067Z","steps":["trace[1876596374] 'agreement among raft nodes before linearized reading'  (duration: 124.949288ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:58:59.703917Z","caller":"traceutil/trace.go:171","msg":"trace[1833858790] transaction","detail":"{read_only:false; response_revision:2026; number_of_response:1; }","duration":"118.879803ms","start":"2026-10-15T18:58:59.585008Z","end":"2026-10-15T18:58:59.703888Z","steps":["trace[1833858790] 'process raft request'  (duration: 101.665061ms)","trace[1833858790] 'compare'  (duration: 16.94037ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T18:58:59.703935Z","caller":"traceutil/trace.go:171","msg":"trace[347368648] transaction","detail":"{read_only:false; response_revision:2028; number_of_response:1; }","duration":"116.187315ms","start":"2026-10-15T18:58:59.587726Z","end":"2026-10-15T18:58:59.703913Z","steps":["trace[347368648] 'process raft request'  (duration: 116.095733ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:58:59.704301Z","caller":"traceutil/trace.go:171","msg":"trace[1769750476] transaction","detail":"{read_only:false; response_revision:2027; number_of_response:1; }","duration":"118.995634ms","start":"2026-10-15T18:58:59.58524Z","end":"2026-10-15T18:58:59.704235Z","steps":["trace[1769750476] 'process raft request'  (duration: 118.523669ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:59:02.490101Z","caller":"traceutil/trace.go:171","msg":"trace[1470441001] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"105.91504ms","start":"2026-10-15T18:59:02.384094Z","end":"2026-10-15T18:59:02.490009Z","steps":["trace[1470441001] 'process raft request'  (duration: 105.493725ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:59:03.430134Z","caller":"traceutil/trace.go:171","msg":"trace[22547708] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"176.844796ms","start":"2026-10-15T18:59:03.25326Z","end":"2026-10-15T18:59:03.430105Z","steps":["trace[22547708] 'process raft request'  (duration: 176.666784ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:59:26.092591Z","caller":"traceutil/trace.go:171","msg":"trace[709611825] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"131.83313ms","start":"2026-10-15T18:59:25.960709Z","end":"2026-10-15T18:59:26.092542Z","steps":["trace[709611825] 'process raft request'  (duration: 131.584151ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T18:59:26.959974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.759886ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897051583236741 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2170 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-15T18:59:26.960146Z","caller":"traceutil/trace.go:171","msg":"trace[769862238] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"281.88519ms","start":"2026-10-15T18:59:26.678222Z","end":"2026-10-15T18:59:26.960108Z","steps":["trace[769862238] 'process raft request'  (duration: 131.881935ms)","trace[769862238] 'compare'  (duration: 149.195624ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T18:59:26.960579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.199418ms","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-10-15T18:59:26.960625Z","caller":"traceutil/trace.go:171","msg":"trace[1757232280] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2179; }","duration":"268.269111ms","start":"2026-10-15T18:59:26.692345Z","end":"2026-10-15T18:59:26.960614Z","steps":["trace[1757232280] 'agreement among raft nodes before linearized reading'  (duration: 267.919898ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:59:26.960236Z","caller":"traceutil/trace.go:171","msg":"trace[1179288630] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2258; }","duration":"267.713311ms","start":"2026-10-15T18:59:26.692368Z","end":"2026-10-15T18:59:26.960081Z","steps":["trace[1179288630] 'read index received'  (duration: 117.81474ms)","trace[1179288630] 'applied index is now lower than readState.Index'  (duration: 149.89689ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T18:59:26.961247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.973166ms","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-10-15T18:59:26.9613Z","caller":"traceutil/trace.go:171","msg":"trace[2029391569] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2179; }","duration":"118.089611ms","start":"2026-10-15T18:59:26.843194Z","end":"2026-10-15T18:59:26.961283Z","steps":["trace[2029391569] 'agreement among raft nodes before linearized reading'  (duration: 117.858272ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:59:27.187617Z","caller":"traceutil/trace.go:171","msg":"trace[1917452338] linearizableReadLoop","detail":"{readStateIndex:2261; appliedIndex:2260; }","duration":"127.464971ms","start":"2026-10-15T18:59:27.060115Z","end":"2026-10-15T18:59:27.18758Z","steps":["trace[1917452338] 'read index received'  (duration: 122.202632ms)","trace[1917452338] 'applied index is now lower than readState.Index'  (duration: 5.261269ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T18:59:27.187829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.6908ms","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-10-15T18:59:27.187867Z","caller":"traceutil/trace.go:171","msg":"trace[420374450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2181; }","duration":"127.775573ms","start":"2026-10-15T18:59:27.060082Z","end":"2026-10-15T18:59:27.187857Z","steps":["trace[420374450] 'agreement among raft nodes before linearized reading'  (duration: 127.609857ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T18:59:27.187955Z","caller":"traceutil/trace.go:171","msg":"trace[990722649] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"222.168151ms","start":"2026-10-15T18:59:26.965748Z","end":"2026-10-15T18:59:27.187916Z","steps":["trace[990722649] 'process raft request'  (duration: 216.673623ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:00:25.937778Z","caller":"traceutil/trace.go:171","msg":"trace[1643262969] transaction","detail":"{read_only:false; response_revision:2603; number_of_response:1; }","duration":"162.758674ms","start":"2026-10-15T19:00:25.774994Z","end":"2026-10-15T19:00:25.937752Z","steps":["trace[1643262969] 'process raft request'  (duration: 162.62597ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:00:58.587536Z","caller":"traceutil/trace.go:171","msg":"trace[349463719] transaction","detail":"{read_only:false; response_revision:2782; number_of_response:1; }","duration":"169.546336ms","start":"2026-10-15T19:00:58.417966Z","end":"2026-10-15T19:00:58.587512Z","steps":["trace[349463719] 'process raft request'  (duration: 169.415563ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:01:04.153996Z","caller":"traceutil/trace.go:171","msg":"trace[542576654] transaction","detail":"{read_only:false; response_revision:2813; number_of_response:1; }","duration":"157.765063ms","start":"2026-10-15T19:01:03.996192Z","end":"2026-10-15T19:01:04.153957Z","steps":["trace[542576654] 'process raft request'  (duration: 157.537967ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:13.546701Z","caller":"traceutil/trace.go:171","msg":"trace[1377192032] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"187.013719ms","start":"2026-10-15T19:05:13.359662Z","end":"2026-10-15T19:05:13.546676Z","steps":["trace[1377192032] 'process raft request'  (duration: 186.859787ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:13.675542Z","caller":"traceutil/trace.go:171","msg":"trace[475238901] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"117.320826ms","start":"2026-10-15T19:05:13.558196Z","end":"2026-10-15T19:05:13.675517Z","steps":["trace[475238901] 'process raft request'  (duration: 117.020763ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:13.67616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.649421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:5 size:35102"}
{"level":"info","ts":"2026-10-15T19:05:13.676245Z","caller":"traceutil/trace.go:171","msg":"trace[685429257] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:5; response_revision:4665; }","duration":"117.750713ms","start":"2026-10-15T19:05:13.558474Z","end":"2026-10-15T19:05:13.676225Z","steps":["trace[685429257] 'agreement among raft nodes before linearized reading'  (duration: 117.410058ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:13.815545Z","caller":"traceutil/trace.go:171","msg":"trace[1418296155] linearizableReadLoop","detail":"{readStateIndex:4846; appliedIndex:4844; }","duration":"103.583906ms","start":"2026-10-15T19:05:13.711933Z","end":"2026-10-15T19:05:13.815517Z","steps":["trace[1418296155] 'read index received'  (duration: 57.336724ms)","trace[1418296155] 'applied index is now lower than readState.Index'  (duration: 46.246042ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T19:05:13.815833Z","caller":"traceutil/trace.go:171","msg":"trace[615026138] transaction","detail":"{read_only:false; response_revision:4671; number_of_response:1; }","duration":"104.443939ms","start":"2026-10-15T19:05:13.711374Z","end":"2026-10-15T19:05:13.815818Z","steps":["trace[615026138] 'process raft request'  (duration: 103.933551ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:13.816129Z","caller":"traceutil/trace.go:171","msg":"trace[1003474094] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"103.739979ms","start":"2026-10-15T19:05:13.712379Z","end":"2026-10-15T19:05:13.816119Z","steps":["trace[1003474094] 'process raft request'  (duration: 103.073149ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:13.816291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.333757ms","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-10-15T19:05:13.816398Z","caller":"traceutil/trace.go:171","msg":"trace[1884046649] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4672; }","duration":"104.47244ms","start":"2026-10-15T19:05:13.711906Z","end":"2026-10-15T19:05:13.816379Z","steps":["trace[1884046649] 'agreement among raft nodes before linearized reading'  (duration: 104.178326ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:13.817023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.236318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T19:05:13.817117Z","caller":"traceutil/trace.go:171","msg":"trace[1004867027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4672; }","duration":"101.202972ms","start":"2026-10-15T19:05:13.715889Z","end":"2026-10-15T19:05:13.817092Z","steps":["trace[1004867027] 'agreement among raft nodes before linearized reading'  (duration: 100.122356ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:17.408889Z","caller":"traceutil/trace.go:171","msg":"trace[902436455] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"158.200763ms","start":"2026-10-15T19:05:17.250664Z","end":"2026-10-15T19:05:17.408865Z","steps":["trace[902436455] 'process raft request'  (duration: 158.03346ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:17.699145Z","caller":"traceutil/trace.go:171","msg":"trace[1770917607] transaction","detail":"{read_only:false; response_revision:4775; number_of_response:1; }","duration":"112.629362ms","start":"2026-10-15T19:05:17.586494Z","end":"2026-10-15T19:05:17.699123Z","steps":["trace[1770917607] 'process raft request'  (duration: 112.269637ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:25.926907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.735578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-65476889-f6e3-4c72-8cc1-d2199cac1812\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-10-15T19:05:25.927002Z","caller":"traceutil/trace.go:171","msg":"trace[133291950] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-65476889-f6e3-4c72-8cc1-d2199cac1812; range_end:; response_count:1; response_revision:4947; }","duration":"309.85744ms","start":"2026-10-15T19:05:25.61712Z","end":"2026-10-15T19:05:25.926977Z","steps":["trace[133291950] 'range keys from in-memory index tree'  (duration: 309.517475ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:25.927088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:25.617106Z","time spent":"309.971912ms","remote":"127.0.0.1:56812","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-65476889-f6e3-4c72-8cc1-d2199cac1812\" "}
{"level":"info","ts":"2026-10-15T19:05:25.933685Z","caller":"traceutil/trace.go:171","msg":"trace[460168579] linearizableReadLoop","detail":"{readStateIndex:5130; appliedIndex:5129; }","duration":"175.283944ms","start":"2026-10-15T19:05:25.758386Z","end":"2026-10-15T19:05:25.93367Z","steps":["trace[460168579] 'read index received'  (duration: 175.171932ms)","trace[460168579] 'applied index is now lower than readState.Index'  (duration: 111.082µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T19:05:25.933727Z","caller":"traceutil/trace.go:171","msg":"trace[1920328433] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"297.148157ms","start":"2026-10-15T19:05:25.636565Z","end":"2026-10-15T19:05:25.933714Z","steps":["trace[1920328433] 'process raft request'  (duration: 296.968515ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:25.933796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.396905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-15T19:05:25.933832Z","caller":"traceutil/trace.go:171","msg":"trace[212255113] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:4948; }","duration":"175.473997ms","start":"2026-10-15T19:05:25.758347Z","end":"2026-10-15T19:05:25.933821Z","steps":["trace[212255113] 'agreement among raft nodes before linearized reading'  (duration: 175.393516ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:25.968462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.726305ms","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-10-15T19:05:25.968515Z","caller":"traceutil/trace.go:171","msg":"trace[1139985097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4949; }","duration":"142.801606ms","start":"2026-10-15T19:05:25.825702Z","end":"2026-10-15T19:05:25.968504Z","steps":["trace[1139985097] 'agreement among raft nodes before linearized reading'  (duration: 142.647293ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:25.968628Z","caller":"traceutil/trace.go:171","msg":"trace[665027640] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"127.484264ms","start":"2026-10-15T19:05:25.841138Z","end":"2026-10-15T19:05:25.968622Z","steps":["trace[665027640] 'process raft request'  (duration: 127.130299ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:25.968709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.713615ms","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-10-15T19:05:25.968727Z","caller":"traceutil/trace.go:171","msg":"trace[689774839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4949; }","duration":"108.754975ms","start":"2026-10-15T19:05:25.859967Z","end":"2026-10-15T19:05:25.968722Z","steps":["trace[689774839] 'agreement among raft nodes before linearized reading'  (duration: 108.703014ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:26.372684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.204879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T19:05:26.372779Z","caller":"traceutil/trace.go:171","msg":"trace[2136497531] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4953; }","duration":"175.345922ms","start":"2026-10-15T19:05:26.19741Z","end":"2026-10-15T19:05:26.372756Z","steps":["trace[2136497531] 'range keys from in-memory index tree'  (duration: 175.147029ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:30.438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.83003ms","expected-duration":"100ms","prefix":"","request":"header:<ID:587897051583243560 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18dec9634f0a68c9\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18dec9634f0a68c9\" value_size:748 lease:587897051583243441 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-10-15T19:05:30.43841Z","caller":"traceutil/trace.go:171","msg":"trace[1623112805] linearizableReadLoop","detail":"{readStateIndex:5197; appliedIndex:5195; }","duration":"240.958434ms","start":"2026-10-15T19:05:30.197429Z","end":"2026-10-15T19:05:30.438387Z","steps":["trace[1623112805] 'read index received'  (duration: 101.298592ms)","trace[1623112805] 'applied index is now lower than readState.Index'  (duration: 139.658522ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T19:05:30.438492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.067777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T19:05:30.438524Z","caller":"traceutil/trace.go:171","msg":"trace[1373838257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5015; }","duration":"241.151547ms","start":"2026-10-15T19:05:30.197362Z","end":"2026-10-15T19:05:30.438514Z","steps":["trace[1373838257] 'agreement among raft nodes before linearized reading'  (duration: 241.089676ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:30.438429Z","caller":"traceutil/trace.go:171","msg":"trace[155971873] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"331.108877ms","start":"2026-10-15T19:05:30.10726Z","end":"2026-10-15T19:05:30.438369Z","steps":["trace[155971873] 'process raft request'  (duration: 191.418635ms)","trace[155971873] 'compare'  (duration: 138.525115ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T19:05:30.438782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:30.107244Z","time spent":"331.436903ms","remote":"127.0.0.1:56718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":848,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18dec9634f0a68c9\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18dec9634f0a68c9\" value_size:748 lease:587897051583243441 >> failure:<>"}
{"level":"info","ts":"2026-10-15T19:05:30.43837Z","caller":"traceutil/trace.go:171","msg":"trace[1081187741] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"330.63806ms","start":"2026-10-15T19:05:30.107668Z","end":"2026-10-15T19:05:30.438306Z","steps":["trace[1081187741] 'process raft request'  (duration: 330.420377ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:30.43938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:30.107654Z","time spent":"331.593903ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1307,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/persistentvolumes/pvc-65476889-f6e3-4c72-8cc1-d2199cac1812\" mod_revision:5010 > success:<request_put:<key:\"/registry/persistentvolumes/pvc-65476889-f6e3-4c72-8cc1-d2199cac1812\" value_size:1231 >> failure:<request_range:<key:\"/registry/persistentvolumes/pvc-65476889-f6e3-4c72-8cc1-d2199cac1812\" > >"}
{"level":"info","ts":"2026-10-15T19:05:41.37584Z","caller":"traceutil/trace.go:171","msg":"trace[71868478] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"362.316992ms","start":"2026-10-15T19:05:41.013489Z","end":"2026-10-15T19:05:41.375806Z","steps":["trace[71868478] 'process raft request'  (duration: 362.098968ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:41.376002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.66986ms","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-10-15T19:05:41.376088Z","caller":"traceutil/trace.go:171","msg":"trace[1357514009] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5146; }","duration":"275.831182ms","start":"2026-10-15T19:05:41.100238Z","end":"2026-10-15T19:05:41.37607Z","steps":["trace[1357514009] 'agreement among raft nodes before linearized reading'  (duration: 275.632219ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:41.376037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:41.013469Z","time spent":"362.451993ms","remote":"127.0.0.1:56912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5118 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-10-15T19:05:41.376513Z","caller":"traceutil/trace.go:171","msg":"trace[376719897] linearizableReadLoop","detail":"{readStateIndex:5333; appliedIndex:5332; }","duration":"276.173167ms","start":"2026-10-15T19:05:41.100296Z","end":"2026-10-15T19:05:41.376469Z","steps":["trace[376719897] 'read index received'  (duration: 275.250264ms)","trace[376719897] 'applied index is now lower than readState.Index'  (duration: 226.743µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T19:05:41.391958Z","caller":"traceutil/trace.go:171","msg":"trace[1171047016] transaction","detail":"{read_only:false; response_revision:5147; number_of_response:1; }","duration":"250.679664ms","start":"2026-10-15T19:05:41.14126Z","end":"2026-10-15T19:05:41.39194Z","steps":["trace[1171047016] 'process raft request'  (duration: 250.46076ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:41.392009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.116522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16549"}
{"level":"warn","ts":"2026-10-15T19:05:41.392038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.107153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-15T19:05:41.392078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.358231ms","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-10-15T19:05:41.392096Z","caller":"traceutil/trace.go:171","msg":"trace[146822229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5147; }","duration":"195.199115ms","start":"2026-10-15T19:05:41.196883Z","end":"2026-10-15T19:05:41.392082Z","steps":["trace[146822229] 'agreement among raft nodes before linearized reading'  (duration: 195.093073ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:41.392085Z","caller":"traceutil/trace.go:171","msg":"trace[1249689353] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5147; }","duration":"164.237134ms","start":"2026-10-15T19:05:41.227827Z","end":"2026-10-15T19:05:41.392064Z","steps":["trace[1249689353] 'agreement among raft nodes before linearized reading'  (duration: 164.022401ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:41.392083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.546469ms","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-10-15T19:05:41.392127Z","caller":"traceutil/trace.go:171","msg":"trace[1106995691] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5147; }","duration":"151.430243ms","start":"2026-10-15T19:05:41.240682Z","end":"2026-10-15T19:05:41.392112Z","steps":["trace[1106995691] 'agreement among raft nodes before linearized reading'  (duration: 151.301881ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:41.392158Z","caller":"traceutil/trace.go:171","msg":"trace[3042291] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5147; }","duration":"164.685751ms","start":"2026-10-15T19:05:41.227454Z","end":"2026-10-15T19:05:41.392139Z","steps":["trace[3042291] 'agreement among raft nodes before linearized reading'  (duration: 164.440557ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:05:41.392761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.879906ms","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-10-15T19:05:41.392812Z","caller":"traceutil/trace.go:171","msg":"trace[792599609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5147; }","duration":"276.973487ms","start":"2026-10-15T19:05:41.115825Z","end":"2026-10-15T19:05:41.392798Z","steps":["trace[792599609] 'agreement among raft nodes before linearized reading'  (duration: 276.630712ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:05:41.523883Z","caller":"traceutil/trace.go:171","msg":"trace[645642802] transaction","detail":"{read_only:false; response_revision:5151; number_of_response:1; }","duration":"102.415796ms","start":"2026-10-15T19:05:41.421435Z","end":"2026-10-15T19:05:41.52385Z","steps":["trace[645642802] 'process raft request'  (duration: 60.820085ms)","trace[645642802] 'compare'  (duration: 41.428709ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T19:06:19.433142Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2894}
{"level":"info","ts":"2026-10-15T19:06:19.566498Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2894,"took":"132.062362ms","hash":2439304466,"current-db-size-bytes":53583872,"current-db-size":"54 MB","current-db-size-in-use-bytes":28491776,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-15T19:06:19.566562Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2439304466,"revision":2894,"compact-revision":-1}
{"level":"warn","ts":"2026-10-15T19:09:47.771267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.663499ms","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-10-15T19:09:47.771348Z","caller":"traceutil/trace.go:171","msg":"trace[458005156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6931; }","duration":"124.790303ms","start":"2026-10-15T19:09:47.64654Z","end":"2026-10-15T19:09:47.771331Z","steps":["trace[458005156] 'range keys from in-memory index tree'  (duration: 124.32626ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T19:09:47.771591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.383912ms","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-10-15T19:09:47.771623Z","caller":"traceutil/trace.go:171","msg":"trace[1118446064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6931; }","duration":"121.441314ms","start":"2026-10-15T19:09:47.650173Z","end":"2026-10-15T19:09:47.771614Z","steps":["trace[1118446064] 'range keys from in-memory index tree'  (duration: 121.29149ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T19:11:19.440168Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5475}
{"level":"info","ts":"2026-10-15T19:11:19.572342Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5475,"took":"130.072292ms","hash":1833056549,"current-db-size-bytes":53583872,"current-db-size":"54 MB","current-db-size-in-use-bytes":18550784,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-10-15T19:11:19.572421Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1833056549,"revision":5475,"compact-revision":2894}