{"level":"warn","ts":"2026-09-14T16:14:26.474103Z","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-14T16:14:26.474222Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.181: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.181:2380","--initial-cluster=instance=https://162.253.55.181:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.181:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.181: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-14T16:14:26.474371Z","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-14T16:14:26.474387Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.181:2380"]} {"level":"info","ts":"2026-09-14T16:14:26.474427Z","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-14T16:14:26.475165Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.181:2379"]} {"level":"info","ts":"2026-09-14T16:14:26.475705Z","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.181:2380"],"listen-peer-urls":["https://162.253.55.181:2380"],"advertise-client-urls":["https://162.253.55.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.181: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-14T16:14:26.480887Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.858817ms"} {"level":"info","ts":"2026-09-14T16:14:26.488364Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"865c2c1f02504fb9","cluster-id":"c3b098aaa499ad51"} {"level":"info","ts":"2026-09-14T16:14:26.488474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 switched to configuration voters=()"} {"level":"info","ts":"2026-09-14T16:14:26.488505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 became follower at term 0"} {"level":"info","ts":"2026-09-14T16:14:26.488518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 865c2c1f02504fb9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-14T16:14:26.488528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 became follower at term 1"} {"level":"info","ts":"2026-09-14T16:14:26.488569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 switched to configuration voters=(9681661810634149817)"} {"level":"warn","ts":"2026-09-14T16:14:26.49602Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-14T16:14:26.497593Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-14T16:14:26.498854Z","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-14T16:14:26.500761Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"865c2c1f02504fb9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-14T16:14:26.501083Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"865c2c1f02504fb9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-14T16:14:26.501381Z","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-14T16:14:26.501466Z","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-14T16:14:26.501522Z","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-14T16:14:26.503314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 switched to configuration voters=(9681661810634149817)"} {"level":"info","ts":"2026-09-14T16:14:26.503437Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c3b098aaa499ad51","local-member-id":"865c2c1f02504fb9","added-peer-id":"865c2c1f02504fb9","added-peer-peer-urls":["https://162.253.55.181:2380"]} {"level":"info","ts":"2026-09-14T16:14:26.505036Z","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-14T16:14:26.505217Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.181:2380"} {"level":"info","ts":"2026-09-14T16:14:26.505334Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.181:2380"} {"level":"info","ts":"2026-09-14T16:14:26.505979Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-14T16:14:26.50593Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"865c2c1f02504fb9","initial-advertise-peer-urls":["https://162.253.55.181:2380"],"listen-peer-urls":["https://162.253.55.181:2380"],"advertise-client-urls":["https://162.253.55.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-14T16:14:27.28926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 is starting a new election at term 1"} {"level":"info","ts":"2026-09-14T16:14:27.289346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-14T16:14:27.289408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 received MsgPreVoteResp from 865c2c1f02504fb9 at term 1"} {"level":"info","ts":"2026-09-14T16:14:27.289442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 became candidate at term 2"} {"level":"info","ts":"2026-09-14T16:14:27.289461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 received MsgVoteResp from 865c2c1f02504fb9 at term 2"} {"level":"info","ts":"2026-09-14T16:14:27.289489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 became leader at term 2"} {"level":"info","ts":"2026-09-14T16:14:27.289513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 865c2c1f02504fb9 elected leader 865c2c1f02504fb9 at term 2"} {"level":"info","ts":"2026-09-14T16:14:27.291122Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"865c2c1f02504fb9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.181:2379]}","request-path":"/0/members/865c2c1f02504fb9/attributes","cluster-id":"c3b098aaa499ad51","publish-timeout":"7s"} {"level":"info","ts":"2026-09-14T16:14:27.291196Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-14T16:14:27.291169Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-14T16:14:27.291099Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T16:14:27.291422Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-14T16:14:27.291465Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-14T16:14:27.29238Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c3b098aaa499ad51","local-member-id":"865c2c1f02504fb9","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T16:14:27.292519Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T16:14:27.292551Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T16:14:27.294351Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-14T16:14:27.298118Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.181:2379"} {"level":"warn","ts":"2026-09-14T16:14:34.677512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.385718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-14T16:14:34.677657Z","caller":"traceutil/trace.go:171","msg":"trace[483074282] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:318; }","duration":"303.590908ms","start":"2026-09-14T16:14:34.374033Z","end":"2026-09-14T16:14:34.677624Z","steps":["trace[483074282] 'range keys from in-memory index tree' (duration: 303.076724ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:14:34.677729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T16:14:34.373995Z","time spent":"303.711383ms","remote":"127.0.0.1:39846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-09-14T16:14:34.865885Z","caller":"traceutil/trace.go:171","msg":"trace[496462748] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"182.848971ms","start":"2026-09-14T16:14:34.683009Z","end":"2026-09-14T16:14:34.865858Z","steps":["trace[496462748] 'process raft request' (duration: 182.690224ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:14:35.161405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.114259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-14T16:14:35.161538Z","caller":"traceutil/trace.go:171","msg":"trace[446180819] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:329; }","duration":"327.791101ms","start":"2026-09-14T16:14:34.833727Z","end":"2026-09-14T16:14:35.161518Z","steps":["trace[446180819] 'read index received' (duration: 31.978675ms)","trace[446180819] 'applied index is now lower than readState.Index' (duration: 295.810796ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T16:14:35.161598Z","caller":"traceutil/trace.go:171","msg":"trace[1827383153] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"477.996649ms","start":"2026-09-14T16:14:34.683559Z","end":"2026-09-14T16:14:35.161556Z","steps":["trace[1827383153] 'process raft request' (duration: 356.015691ms)","trace[1827383153] 'compare' (duration: 120.906371ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T16:14:35.16167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.951848ms","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-14T16:14:35.161762Z","caller":"traceutil/trace.go:171","msg":"trace[1285341232] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:320; }","duration":"328.085195ms","start":"2026-09-14T16:14:34.833666Z","end":"2026-09-14T16:14:35.161751Z","steps":["trace[1285341232] 'agreement among raft nodes before linearized reading' (duration: 327.953448ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:14:35.161832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T16:14:34.83364Z","time spent":"328.161478ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-14T16:14:35.161801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.85822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-09-14T16:14:35.161904Z","caller":"traceutil/trace.go:171","msg":"trace[140403121] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:320; }","duration":"292.011477ms","start":"2026-09-14T16:14:34.869867Z","end":"2026-09-14T16:14:35.161879Z","steps":["trace[140403121] 'agreement among raft nodes before linearized reading' (duration: 291.817127ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:14:35.161902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T16:14:34.683526Z","time spent":"478.205537ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-14T16:15:16.827326Z","caller":"traceutil/trace.go:171","msg":"trace[910308252] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"274.610234ms","start":"2026-09-14T16:15:16.552636Z","end":"2026-09-14T16:15:16.827246Z","steps":["trace[910308252] 'process raft request' (duration: 273.829882ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:15:17.42327Z","caller":"traceutil/trace.go:171","msg":"trace[204776807] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"535.497753ms","start":"2026-09-14T16:15:16.887737Z","end":"2026-09-14T16:15:17.423235Z","steps":["trace[204776807] 'process raft request' (duration: 535.286677ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:15:17.423453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T16:15:16.88767Z","time spent":"535.689078ms","remote":"127.0.0.1:39926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-14T16:15:17.457038Z","caller":"traceutil/trace.go:171","msg":"trace[501010013] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"546.049634ms","start":"2026-09-14T16:15:16.910939Z","end":"2026-09-14T16:15:17.456989Z","steps":["trace[501010013] 'process raft request' (duration: 545.781866ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:15:17.457283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T16:15:16.910911Z","time spent":"546.28004ms","remote":"127.0.0.1:40102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-14T16:15:19.12496Z","caller":"traceutil/trace.go:171","msg":"trace[1070173215] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"120.116895ms","start":"2026-09-14T16:15:19.004814Z","end":"2026-09-14T16:15:19.124931Z","steps":["trace[1070173215] 'process raft request' (duration: 119.92838ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:16:57.541159Z","caller":"traceutil/trace.go:171","msg":"trace[223058297] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"148.459727ms","start":"2026-09-14T16:16:57.392669Z","end":"2026-09-14T16:16:57.541129Z","steps":["trace[223058297] 'process raft request' (duration: 148.263464ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:16:57.876666Z","caller":"traceutil/trace.go:171","msg":"trace[1127975161] linearizableReadLoop","detail":"{readStateIndex:1992; appliedIndex:1990; }","duration":"475.510163ms","start":"2026-09-14T16:16:57.401122Z","end":"2026-09-14T16:16:57.876632Z","steps":["trace[1127975161] 'read index received' (duration: 139.912111ms)","trace[1127975161] 'applied index is now lower than readState.Index' (duration: 335.596702ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T16:16:57.876759Z","caller":"traceutil/trace.go:171","msg":"trace[1639737521] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"483.614614ms","start":"2026-09-14T16:16:57.39312Z","end":"2026-09-14T16:16:57.876734Z","steps":["trace[1639737521] 'process raft request' (duration: 483.329309ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:16:57.876845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.702018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T16:16:57.876943Z","caller":"traceutil/trace.go:171","msg":"trace[2108063138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1919; }","duration":"475.849079ms","start":"2026-09-14T16:16:57.401077Z","end":"2026-09-14T16:16:57.876926Z","steps":["trace[2108063138] 'agreement among raft nodes before linearized reading' (duration: 475.703917ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:16:57.877013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T16:16:57.401065Z","time spent":"475.93276ms","remote":"127.0.0.1:39732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-14T16:16:57.877004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T16:16:57.39309Z","time spent":"483.717766ms","remote":"127.0.0.1:39926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-14T16:16:57.891982Z","caller":"traceutil/trace.go:171","msg":"trace[1631732174] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"280.771955ms","start":"2026-09-14T16:16:57.611179Z","end":"2026-09-14T16:16:57.891951Z","steps":["trace[1631732174] 'process raft request' (duration: 280.597712ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:16:57.892142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.497442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-09-14T16:16:57.892202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.957537ms","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-09-14T16:16:57.892746Z","caller":"traceutil/trace.go:171","msg":"trace[417956155] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1920; }","duration":"397.527746ms","start":"2026-09-14T16:16:57.495184Z","end":"2026-09-14T16:16:57.892712Z","steps":["trace[417956155] 'agreement among raft nodes before linearized reading' (duration: 396.900606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:16:57.892811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T16:16:57.495158Z","time spent":"397.636457ms","remote":"127.0.0.1:54806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-09-14T16:16:57.892256Z","caller":"traceutil/trace.go:171","msg":"trace[607321295] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1920; }","duration":"219.718007ms","start":"2026-09-14T16:16:57.672518Z","end":"2026-09-14T16:16:57.892236Z","steps":["trace[607321295] 'agreement among raft nodes before linearized reading' (duration: 219.417492ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:16:58.224741Z","caller":"traceutil/trace.go:171","msg":"trace[1570436188] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"325.668346ms","start":"2026-09-14T16:16:57.899044Z","end":"2026-09-14T16:16:58.224712Z","steps":["trace[1570436188] 'process raft request' (duration: 325.470373ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:16:58.224935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T16:16:57.899016Z","time spent":"325.808368ms","remote":"127.0.0.1:40002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-14T16:16:58.315239Z","caller":"traceutil/trace.go:171","msg":"trace[66019838] linearizableReadLoop","detail":"{readStateIndex:1995; appliedIndex:1993; }","duration":"231.70243ms","start":"2026-09-14T16:16:58.083495Z","end":"2026-09-14T16:16:58.315197Z","steps":["trace[66019838] 'read index received' (duration: 141.03819ms)","trace[66019838] 'applied index is now lower than readState.Index' (duration: 90.6629ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T16:16:58.315373Z","caller":"traceutil/trace.go:171","msg":"trace[1654257036] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"408.902826ms","start":"2026-09-14T16:16:57.906429Z","end":"2026-09-14T16:16:58.315332Z","steps":["trace[1654257036] 'process raft request' (duration: 408.426568ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:16:58.315542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.030045ms","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-14T16:16:58.315587Z","caller":"traceutil/trace.go:171","msg":"trace[2078468887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1922; }","duration":"232.135576ms","start":"2026-09-14T16:16:58.08344Z","end":"2026-09-14T16:16:58.315575Z","steps":["trace[2078468887] 'agreement among raft nodes before linearized reading' (duration: 231.935404ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:16:58.315592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T16:16:57.906396Z","time spent":"409.079839ms","remote":"127.0.0.1:39926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10964,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-14T16:16:58.315658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.803859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4ccb7ed3-6437-49ed-8ddc-6785b36d6c8c\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-09-14T16:16:58.315739Z","caller":"traceutil/trace.go:171","msg":"trace[1057608506] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4ccb7ed3-6437-49ed-8ddc-6785b36d6c8c; range_end:; response_count:1; response_revision:1922; }","duration":"177.9221ms","start":"2026-09-14T16:16:58.137802Z","end":"2026-09-14T16:16:58.315724Z","steps":["trace[1057608506] 'agreement among raft nodes before linearized reading' (duration: 177.684247ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:16:58.315808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.117422ms","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-14T16:16:58.315885Z","caller":"traceutil/trace.go:171","msg":"trace[591651921] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1922; }","duration":"195.195714ms","start":"2026-09-14T16:16:58.120652Z","end":"2026-09-14T16:16:58.315848Z","steps":["trace[591651921] 'agreement among raft nodes before linearized reading' (duration: 195.066102ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:16:58.316028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.015268ms","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-14T16:16:58.316071Z","caller":"traceutil/trace.go:171","msg":"trace[1191870383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1922; }","duration":"207.082099ms","start":"2026-09-14T16:16:58.10898Z","end":"2026-09-14T16:16:58.316062Z","steps":["trace[1191870383] 'agreement among raft nodes before linearized reading' (duration: 206.45523ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:17:08.646286Z","caller":"traceutil/trace.go:171","msg":"trace[1659466896] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"122.11038ms","start":"2026-09-14T16:17:08.524151Z","end":"2026-09-14T16:17:08.646261Z","steps":["trace[1659466896] 'process raft request' (duration: 86.161001ms)","trace[1659466896] 'compare' (duration: 35.696965ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T16:17:08.646939Z","caller":"traceutil/trace.go:171","msg":"trace[776675999] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"122.443335ms","start":"2026-09-14T16:17:08.52448Z","end":"2026-09-14T16:17:08.646923Z","steps":["trace[776675999] 'process raft request' (duration: 121.740034ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:17:08.647511Z","caller":"traceutil/trace.go:171","msg":"trace[169581575] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"122.84063ms","start":"2026-09-14T16:17:08.52465Z","end":"2026-09-14T16:17:08.647491Z","steps":["trace[169581575] 'process raft request' (duration: 122.10276ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:17:14.222044Z","caller":"traceutil/trace.go:171","msg":"trace[1706382685] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"175.980566ms","start":"2026-09-14T16:17:14.046014Z","end":"2026-09-14T16:17:14.221995Z","steps":["trace[1706382685] 'process raft request' (duration: 175.820434ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:17:14.222681Z","caller":"traceutil/trace.go:171","msg":"trace[226670260] linearizableReadLoop","detail":"{readStateIndex:2136; appliedIndex:2136; }","duration":"131.876493ms","start":"2026-09-14T16:17:14.09076Z","end":"2026-09-14T16:17:14.222637Z","steps":["trace[226670260] 'read index received' (duration: 131.871402ms)","trace[226670260] 'applied index is now lower than readState.Index' (duration: 4.26µs)"],"step_count":2} {"level":"warn","ts":"2026-09-14T16:17:14.222858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.083575ms","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-09-14T16:17:14.222888Z","caller":"traceutil/trace.go:171","msg":"trace[1059970121] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2059; }","duration":"132.173257ms","start":"2026-09-14T16:17:14.090705Z","end":"2026-09-14T16:17:14.222878Z","steps":["trace[1059970121] 'agreement among raft nodes before linearized reading' (duration: 132.013195ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:17:36.494774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.814198ms","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-09-14T16:17:36.494941Z","caller":"traceutil/trace.go:171","msg":"trace[1358530379] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2182; }","duration":"116.401225ms","start":"2026-09-14T16:17:36.378512Z","end":"2026-09-14T16:17:36.494913Z","steps":["trace[1358530379] 'range keys from in-memory index tree' (duration: 115.498304ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:17:36.722068Z","caller":"traceutil/trace.go:171","msg":"trace[445632525] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"139.036423ms","start":"2026-09-14T16:17:36.583006Z","end":"2026-09-14T16:17:36.722042Z","steps":["trace[445632525] 'process raft request' (duration: 138.789999ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:17:36.722536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.542801ms","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-14T16:17:36.722567Z","caller":"traceutil/trace.go:171","msg":"trace[458610774] linearizableReadLoop","detail":"{readStateIndex:2268; appliedIndex:2266; }","duration":"129.993474ms","start":"2026-09-14T16:17:36.591943Z","end":"2026-09-14T16:17:36.721936Z","steps":["trace[458610774] 'read index received' (duration: 20.303255ms)","trace[458610774] 'applied index is now lower than readState.Index' (duration: 109.689149ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T16:17:36.722679Z","caller":"traceutil/trace.go:171","msg":"trace[354056944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2185; }","duration":"130.754204ms","start":"2026-09-14T16:17:36.591893Z","end":"2026-09-14T16:17:36.722648Z","steps":["trace[354056944] 'agreement among raft nodes before linearized reading' (duration: 130.263438ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:17:36.755489Z","caller":"traceutil/trace.go:171","msg":"trace[1427303076] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"126.60545ms","start":"2026-09-14T16:17:36.628849Z","end":"2026-09-14T16:17:36.755454Z","steps":["trace[1427303076] 'process raft request' (duration: 126.260985ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:17:36.755636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.202537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-14T16:17:36.755734Z","caller":"traceutil/trace.go:171","msg":"trace[901667772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2186; }","duration":"159.327068ms","start":"2026-09-14T16:17:36.596383Z","end":"2026-09-14T16:17:36.75571Z","steps":["trace[901667772] 'agreement among raft nodes before linearized reading' (duration: 159.131636ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:17:36.756016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.041327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-14T16:17:36.756075Z","caller":"traceutil/trace.go:171","msg":"trace[759834133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2186; }","duration":"163.116768ms","start":"2026-09-14T16:17:36.592944Z","end":"2026-09-14T16:17:36.75606Z","steps":["trace[759834133] 'agreement among raft nodes before linearized reading' (duration: 162.437589ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:17:36.956831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.127785ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-14T16:17:36.957112Z","caller":"traceutil/trace.go:171","msg":"trace[966261929] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"196.491855ms","start":"2026-09-14T16:17:36.760594Z","end":"2026-09-14T16:17:36.957086Z","steps":["trace[966261929] 'process raft request' (duration: 196.359213ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:17:36.957478Z","caller":"traceutil/trace.go:171","msg":"trace[1190338448] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"196.953002ms","start":"2026-09-14T16:17:36.760492Z","end":"2026-09-14T16:17:36.957445Z","steps":["trace[1190338448] 'compare' (duration: 187.588668ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:17:37.50981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.577184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T16:17:37.509908Z","caller":"traceutil/trace.go:171","msg":"trace[62769803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2191; }","duration":"106.733945ms","start":"2026-09-14T16:17:37.403155Z","end":"2026-09-14T16:17:37.509889Z","steps":["trace[62769803] 'range keys from in-memory index tree' (duration: 106.468392ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:17:37.941813Z","caller":"traceutil/trace.go:171","msg":"trace[1532382113] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"267.223253ms","start":"2026-09-14T16:17:37.674565Z","end":"2026-09-14T16:17:37.941788Z","steps":["trace[1532382113] 'process raft request' (duration: 267.095392ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:18:39.239304Z","caller":"traceutil/trace.go:171","msg":"trace[1876149401] transaction","detail":"{read_only:false; response_revision:2624; number_of_response:1; }","duration":"242.171602ms","start":"2026-09-14T16:18:38.997079Z","end":"2026-09-14T16:18:39.239251Z","steps":["trace[1876149401] 'process raft request' (duration: 241.97217ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:18:39.257125Z","caller":"traceutil/trace.go:171","msg":"trace[304638938] linearizableReadLoop","detail":"{readStateIndex:2722; appliedIndex:2720; }","duration":"224.665834ms","start":"2026-09-14T16:18:39.032442Z","end":"2026-09-14T16:18:39.257108Z","steps":["trace[304638938] 'read index received' (duration: 206.581739ms)","trace[304638938] 'applied index is now lower than readState.Index' (duration: 18.083165ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T16:18:39.257204Z","caller":"traceutil/trace.go:171","msg":"trace[1377754633] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"258.743919ms","start":"2026-09-14T16:18:38.998453Z","end":"2026-09-14T16:18:39.257196Z","steps":["trace[1377754633] 'process raft request' (duration: 258.543377ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:18:39.257362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.914487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-14T16:18:39.257411Z","caller":"traceutil/trace.go:171","msg":"trace[1728849156] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2625; }","duration":"225.010797ms","start":"2026-09-14T16:18:39.032394Z","end":"2026-09-14T16:18:39.257405Z","steps":["trace[1728849156] 'agreement among raft nodes before linearized reading' (duration: 224.894516ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:18:39.257578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.007561ms","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-14T16:18:39.257596Z","caller":"traceutil/trace.go:171","msg":"trace[1449895443] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2625; }","duration":"164.028341ms","start":"2026-09-14T16:18:39.093563Z","end":"2026-09-14T16:18:39.257592Z","steps":["trace[1449895443] 'agreement among raft nodes before linearized reading' (duration: 163.977881ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:19:09.75334Z","caller":"traceutil/trace.go:171","msg":"trace[566530718] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"227.891337ms","start":"2026-09-14T16:19:09.525411Z","end":"2026-09-14T16:19:09.753302Z","steps":["trace[566530718] 'process raft request' (duration: 227.701851ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:19:09.754381Z","caller":"traceutil/trace.go:171","msg":"trace[1382935252] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"179.279461ms","start":"2026-09-14T16:19:09.575088Z","end":"2026-09-14T16:19:09.754368Z","steps":["trace[1382935252] 'process raft request' (duration: 179.189748ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T16:23:46.534144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.48562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T16:23:46.534189Z","caller":"traceutil/trace.go:171","msg":"trace[1085824946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4927; }","duration":"134.566411ms","start":"2026-09-14T16:23:46.399613Z","end":"2026-09-14T16:23:46.53418Z","steps":["trace[1085824946] 'agreement among raft nodes before linearized reading' (duration: 134.486379ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:23:46.53395Z","caller":"traceutil/trace.go:171","msg":"trace[839184060] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"166.820397ms","start":"2026-09-14T16:23:46.367095Z","end":"2026-09-14T16:23:46.533916Z","steps":["trace[839184060] 'process raft request' (duration: 74.188717ms)","trace[839184060] 'compare' (duration: 92.301125ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T16:23:46.534012Z","caller":"traceutil/trace.go:171","msg":"trace[1842217208] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"160.480781ms","start":"2026-09-14T16:23:46.373516Z","end":"2026-09-14T16:23:46.533997Z","steps":["trace[1842217208] 'process raft request' (duration: 160.181686ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:23:46.533774Z","caller":"traceutil/trace.go:171","msg":"trace[611010105] linearizableReadLoop","detail":"{readStateIndex:5117; appliedIndex:5115; }","duration":"134.104974ms","start":"2026-09-14T16:23:46.399648Z","end":"2026-09-14T16:23:46.533753Z","steps":["trace[611010105] 'read index received' (duration: 41.649006ms)","trace[611010105] 'applied index is now lower than readState.Index' (duration: 92.455118ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T16:23:46.542311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.568919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-14T16:23:46.542396Z","caller":"traceutil/trace.go:171","msg":"trace[439903173] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4928; }","duration":"138.701691ms","start":"2026-09-14T16:23:46.403675Z","end":"2026-09-14T16:23:46.542377Z","steps":["trace[439903173] 'agreement among raft nodes before linearized reading' (duration: 138.467447ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:23:51.873525Z","caller":"traceutil/trace.go:171","msg":"trace[86115662] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"134.150741ms","start":"2026-09-14T16:23:51.739314Z","end":"2026-09-14T16:23:51.873465Z","steps":["trace[86115662] 'process raft request' (duration: 133.55046ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:23:52.110154Z","caller":"traceutil/trace.go:171","msg":"trace[1360125066] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"163.275811ms","start":"2026-09-14T16:23:51.946856Z","end":"2026-09-14T16:23:52.110132Z","steps":["trace[1360125066] 'process raft request' (duration: 163.151039ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:23:56.844756Z","caller":"traceutil/trace.go:171","msg":"trace[1150924984] transaction","detail":"{read_only:false; response_revision:5089; number_of_response:1; }","duration":"142.534339ms","start":"2026-09-14T16:23:56.702198Z","end":"2026-09-14T16:23:56.844733Z","steps":["trace[1150924984] 'process raft request' (duration: 142.399927ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:23:56.961924Z","caller":"traceutil/trace.go:171","msg":"trace[378013945] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"116.958821ms","start":"2026-09-14T16:23:56.84494Z","end":"2026-09-14T16:23:56.961899Z","steps":["trace[378013945] 'process raft request' (duration: 64.043173ms)","trace[378013945] 'compare' (duration: 52.763785ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T16:23:58.898536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.070182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-14T16:23:58.898673Z","caller":"traceutil/trace.go:171","msg":"trace[862966778] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5135; }","duration":"171.267644ms","start":"2026-09-14T16:23:58.727386Z","end":"2026-09-14T16:23:58.898654Z","steps":["trace[862966778] 'range keys from in-memory index tree' (duration: 170.183597ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:24:07.887567Z","caller":"traceutil/trace.go:171","msg":"trace[869378841] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"124.369552ms","start":"2026-09-14T16:24:07.763168Z","end":"2026-09-14T16:24:07.887537Z","steps":["trace[869378841] 'process raft request' (duration: 124.156898ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T16:24:27.327908Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2886} {"level":"info","ts":"2026-09-14T16:24:27.411951Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2886,"took":"82.940229ms","hash":3309153102,"current-db-size-bytes":52248576,"current-db-size":"52 MB","current-db-size-in-use-bytes":27639808,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-14T16:24:27.41204Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3309153102,"revision":2886,"compact-revision":-1} {"level":"info","ts":"2026-09-14T16:29:27.334669Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5364} {"level":"info","ts":"2026-09-14T16:29:27.47595Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5364,"took":"139.825845ms","hash":1986852209,"current-db-size-bytes":52248576,"current-db-size":"52 MB","current-db-size-in-use-bytes":18608128,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-14T16:29:27.47602Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1986852209,"revision":5364,"compact-revision":2886}