{"level":"warn","ts":"2026-10-07T21:57:24.413006Z","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-07T21:57:24.413068Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.239: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.239:2380","--initial-cluster=instance=https://162.253.55.239:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.239:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.239: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-07T21:57:24.413118Z","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-07T21:57:24.413128Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.239:2380"]} {"level":"info","ts":"2026-10-07T21:57:24.413147Z","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-07T21:57:24.413647Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.239:2379"]} {"level":"info","ts":"2026-10-07T21:57:24.413711Z","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.239:2380"],"listen-peer-urls":["https://162.253.55.239:2380"],"advertise-client-urls":["https://162.253.55.239:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.239:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.239: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-07T21:57:24.417731Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.825519ms"} {"level":"info","ts":"2026-10-07T21:57:24.428566Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"548b318b3528a14c","cluster-id":"8bf5e58b9331730a"} {"level":"info","ts":"2026-10-07T21:57:24.428674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c switched to configuration voters=()"} {"level":"info","ts":"2026-10-07T21:57:24.42871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became follower at term 0"} {"level":"info","ts":"2026-10-07T21:57:24.428729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 548b318b3528a14c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-07T21:57:24.428741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became follower at term 1"} {"level":"info","ts":"2026-10-07T21:57:24.428792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c switched to configuration voters=(6092017394910798156)"} {"level":"warn","ts":"2026-10-07T21:57:24.437716Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-07T21:57:24.442537Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-07T21:57:24.445833Z","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-07T21:57:24.451319Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"548b318b3528a14c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-07T21:57:24.453568Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"548b318b3528a14c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-07T21:57:24.453759Z","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-07T21:57:24.453827Z","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-07T21:57:24.453845Z","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-07T21:57:24.454424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c switched to configuration voters=(6092017394910798156)"} {"level":"info","ts":"2026-10-07T21:57:24.454582Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8bf5e58b9331730a","local-member-id":"548b318b3528a14c","added-peer-id":"548b318b3528a14c","added-peer-peer-urls":["https://162.253.55.239:2380"]} {"level":"info","ts":"2026-10-07T21:57:24.455864Z","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-07T21:57:24.456111Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"548b318b3528a14c","initial-advertise-peer-urls":["https://162.253.55.239:2380"],"listen-peer-urls":["https://162.253.55.239:2380"],"advertise-client-urls":["https://162.253.55.239:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.239:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-07T21:57:24.45615Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-07T21:57:24.456305Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.239:2380"} {"level":"info","ts":"2026-10-07T21:57:24.456327Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.239:2380"} {"level":"info","ts":"2026-10-07T21:57:24.529177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c is starting a new election at term 1"} {"level":"info","ts":"2026-10-07T21:57:24.529221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became pre-candidate at term 1"} {"level":"info","ts":"2026-10-07T21:57:24.529246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c received MsgPreVoteResp from 548b318b3528a14c at term 1"} {"level":"info","ts":"2026-10-07T21:57:24.529257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became candidate at term 2"} {"level":"info","ts":"2026-10-07T21:57:24.529262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c received MsgVoteResp from 548b318b3528a14c at term 2"} {"level":"info","ts":"2026-10-07T21:57:24.52927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became leader at term 2"} {"level":"info","ts":"2026-10-07T21:57:24.529276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 548b318b3528a14c elected leader 548b318b3528a14c at term 2"} {"level":"info","ts":"2026-10-07T21:57:24.530041Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T21:57:24.530869Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"548b318b3528a14c","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.239:2379]}","request-path":"/0/members/548b318b3528a14c/attributes","cluster-id":"8bf5e58b9331730a","publish-timeout":"7s"} {"level":"info","ts":"2026-10-07T21:57:24.530962Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-07T21:57:24.531024Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-07T21:57:24.531442Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8bf5e58b9331730a","local-member-id":"548b318b3528a14c","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T21:57:24.531531Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T21:57:24.531557Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T21:57:24.53442Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-07T21:57:24.534476Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-07T21:57:24.535811Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-07T21:57:24.536345Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.239:2379"} {"level":"warn","ts":"2026-10-07T21:57:28.255953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.536878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-07T21:57:28.256257Z","caller":"traceutil/trace.go:171","msg":"trace[224094604] transaction","detail":"{read_only:false; response_revision:186; number_of_response:1; }","duration":"416.108523ms","start":"2026-10-07T21:57:27.840039Z","end":"2026-10-07T21:57:28.256148Z","steps":["trace[224094604] 'process raft request' (duration: 122.871611ms)","trace[224094604] 'compare' (duration: 292.394755ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T21:57:28.256349Z","caller":"traceutil/trace.go:171","msg":"trace[557291943] transaction","detail":"{read_only:false; response_revision:187; number_of_response:1; }","duration":"414.407868ms","start":"2026-10-07T21:57:27.841915Z","end":"2026-10-07T21:57:28.256323Z","steps":["trace[557291943] 'process raft request' (duration: 414.161053ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:57:28.256459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T21:57:27.841902Z","time spent":"414.502251ms","remote":"127.0.0.1:44242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":694,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T21:57:28.256928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T21:57:27.840027Z","time spent":"416.359549ms","remote":"127.0.0.1:43966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T21:57:28.590023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.109037ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-07T21:57:28.59012Z","caller":"traceutil/trace.go:171","msg":"trace[1448142439] linearizableReadLoop","detail":"{readStateIndex:192; appliedIndex:191; }","duration":"328.742125ms","start":"2026-10-07T21:57:28.261362Z","end":"2026-10-07T21:57:28.590104Z","steps":["trace[1448142439] 'read index received' (duration: 174.353632ms)","trace[1448142439] 'applied index is now lower than readState.Index' (duration: 154.387443ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T21:57:28.590222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.857967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-10-07T21:57:28.590198Z","caller":"traceutil/trace.go:171","msg":"trace[781765340] transaction","detail":"{read_only:false; response_revision:188; number_of_response:1; }","duration":"330.024901ms","start":"2026-10-07T21:57:28.260121Z","end":"2026-10-07T21:57:28.590146Z","steps":["trace[781765340] 'process raft request' (duration: 175.73428ms)","trace[781765340] 'compare' (duration: 154.011385ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T21:57:28.590257Z","caller":"traceutil/trace.go:171","msg":"trace[655875708] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:188; }","duration":"328.942299ms","start":"2026-10-07T21:57:28.261303Z","end":"2026-10-07T21:57:28.590245Z","steps":["trace[655875708] 'agreement among raft nodes before linearized reading' (duration: 328.841127ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:57:28.590341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T21:57:28.260106Z","time spent":"330.165823ms","remote":"127.0.0.1:43966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T21:57:28.590339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T21:57:28.26128Z","time spent":"329.047341ms","remote":"127.0.0.1:44010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-10-07T21:58:08.803619Z","caller":"traceutil/trace.go:171","msg":"trace[56546340] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"117.306901ms","start":"2026-10-07T21:58:08.686294Z","end":"2026-10-07T21:58:08.803601Z","steps":["trace[56546340] 'process raft request' (duration: 116.917155ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T21:58:15.171093Z","caller":"traceutil/trace.go:171","msg":"trace[1682881164] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"167.979901ms","start":"2026-10-07T21:58:15.003042Z","end":"2026-10-07T21:58:15.171022Z","steps":["trace[1682881164] 'process raft request' (duration: 167.061707ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T21:58:15.466304Z","caller":"traceutil/trace.go:171","msg":"trace[347499144] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"222.205513ms","start":"2026-10-07T21:58:15.244056Z","end":"2026-10-07T21:58:15.466262Z","steps":["trace[347499144] 'process raft request' (duration: 221.941779ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:58:16.035771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.688625ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T21:58:16.035967Z","caller":"traceutil/trace.go:171","msg":"trace[1703706945] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"463.455534ms","start":"2026-10-07T21:58:15.572493Z","end":"2026-10-07T21:58:16.035948Z","steps":["trace[1703706945] 'read index received' (duration: 44.421µs)","trace[1703706945] 'applied index is now lower than readState.Index' (duration: 463.409753ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T21:58:16.036105Z","caller":"traceutil/trace.go:171","msg":"trace[1316668344] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"532.197178ms","start":"2026-10-07T21:58:15.503894Z","end":"2026-10-07T21:58:16.036091Z","steps":["trace[1316668344] 'process raft request' (duration: 54.974795ms)","trace[1316668344] 'compare' (duration: 476.514832ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T21:58:16.03621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T21:58:15.503856Z","time spent":"532.314299ms","remote":"127.0.0.1:44166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T21:58:16.036388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.86548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T21:58:16.036492Z","caller":"traceutil/trace.go:171","msg":"trace[2060064768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"464.026902ms","start":"2026-10-07T21:58:15.572437Z","end":"2026-10-07T21:58:16.036464Z","steps":["trace[2060064768] 'agreement among raft nodes before linearized reading' (duration: 463.687557ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:58:16.03663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T21:58:15.572411Z","time spent":"464.205195ms","remote":"127.0.0.1:43906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-07T21:58:16.080002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.736517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ghpkz\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-07T21:58:16.080114Z","caller":"traceutil/trace.go:171","msg":"trace[1140597416] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ghpkz; range_end:; response_count:1; response_revision:651; }","duration":"448.847039ms","start":"2026-10-07T21:58:15.63124Z","end":"2026-10-07T21:58:16.080087Z","steps":["trace[1140597416] 'agreement among raft nodes before linearized reading' (duration: 448.607285ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:58:16.080161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T21:58:15.631206Z","time spent":"448.944991ms","remote":"127.0.0.1:44082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-ghpkz\" "} {"level":"info","ts":"2026-10-07T21:58:16.080448Z","caller":"traceutil/trace.go:171","msg":"trace[918721743] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"205.857131ms","start":"2026-10-07T21:58:15.874547Z","end":"2026-10-07T21:58:16.080404Z","steps":["trace[918721743] 'process raft request' (duration: 204.640522ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T21:58:32.2541Z","caller":"traceutil/trace.go:171","msg":"trace[368909] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"348.004361ms","start":"2026-10-07T21:58:31.906059Z","end":"2026-10-07T21:58:32.254063Z","steps":["trace[368909] 'process raft request' (duration: 347.667056ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:58:32.25434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T21:58:31.906006Z","time spent":"348.204623ms","remote":"127.0.0.1:44066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T21:58:32.256958Z","caller":"traceutil/trace.go:171","msg":"trace[1081329121] linearizableReadLoop","detail":"{readStateIndex:849; appliedIndex:847; }","duration":"141.455851ms","start":"2026-10-07T21:58:32.115472Z","end":"2026-10-07T21:58:32.256928Z","steps":["trace[1081329121] 'read index received' (duration: 138.229435ms)","trace[1081329121] 'applied index is now lower than readState.Index' (duration: 3.225476ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T21:58:32.257196Z","caller":"traceutil/trace.go:171","msg":"trace[1005894434] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"259.956939ms","start":"2026-10-07T21:58:31.997217Z","end":"2026-10-07T21:58:32.257174Z","steps":["trace[1005894434] 'process raft request' (duration: 259.533913ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:58:32.257205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.716165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-10-07T21:58:32.257264Z","caller":"traceutil/trace.go:171","msg":"trace[967915791] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:819; }","duration":"141.839957ms","start":"2026-10-07T21:58:32.115404Z","end":"2026-10-07T21:58:32.257244Z","steps":["trace[967915791] 'agreement among raft nodes before linearized reading' (duration: 141.635134ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T21:59:02.171479Z","caller":"traceutil/trace.go:171","msg":"trace[1773823634] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"141.457624ms","start":"2026-10-07T21:59:02.02999Z","end":"2026-10-07T21:59:02.171447Z","steps":["trace[1773823634] 'process raft request' (duration: 141.254861ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T21:59:27.325278Z","caller":"traceutil/trace.go:171","msg":"trace[747503145] linearizableReadLoop","detail":"{readStateIndex:1535; appliedIndex:1533; }","duration":"151.332019ms","start":"2026-10-07T21:59:27.17392Z","end":"2026-10-07T21:59:27.325252Z","steps":["trace[747503145] 'read index received' (duration: 37.176244ms)","trace[747503145] 'applied index is now lower than readState.Index' (duration: 114.154105ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T21:59:27.325333Z","caller":"traceutil/trace.go:171","msg":"trace[1203448189] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"211.567725ms","start":"2026-10-07T21:59:27.113735Z","end":"2026-10-07T21:59:27.325302Z","steps":["trace[1203448189] 'process raft request' (duration: 211.359683ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:59:27.325457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.522731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-07T21:59:27.325496Z","caller":"traceutil/trace.go:171","msg":"trace[1540717375] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1487; }","duration":"151.639843ms","start":"2026-10-07T21:59:27.173844Z","end":"2026-10-07T21:59:27.325484Z","steps":["trace[1540717375] 'agreement among raft nodes before linearized reading' (duration: 151.555062ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T21:59:53.004216Z","caller":"traceutil/trace.go:171","msg":"trace[1534873769] linearizableReadLoop","detail":"{readStateIndex:1985; appliedIndex:1984; }","duration":"208.56357ms","start":"2026-10-07T21:59:52.79562Z","end":"2026-10-07T21:59:53.004183Z","steps":["trace[1534873769] 'read index received' (duration: 208.35708ms)","trace[1534873769] 'applied index is now lower than readState.Index' (duration: 204.95µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T21:59:53.004312Z","caller":"traceutil/trace.go:171","msg":"trace[2110276287] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"371.208466ms","start":"2026-10-07T21:59:52.633064Z","end":"2026-10-07T21:59:53.004272Z","steps":["trace[2110276287] 'process raft request' (duration: 370.930193ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:59:53.004465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T21:59:52.633028Z","time spent":"371.340872ms","remote":"127.0.0.1:44166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T21:59:53.004801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.431359ms","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-07T21:59:53.004889Z","caller":"traceutil/trace.go:171","msg":"trace[1535855253] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1910; }","duration":"136.540435ms","start":"2026-10-07T21:59:52.868328Z","end":"2026-10-07T21:59:53.004868Z","steps":["trace[1535855253] 'agreement among raft nodes before linearized reading' (duration: 136.055593ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:59:53.005296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.65586ms","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-10-07T21:59:53.005453Z","caller":"traceutil/trace.go:171","msg":"trace[38650963] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1910; }","duration":"209.835267ms","start":"2026-10-07T21:59:52.795565Z","end":"2026-10-07T21:59:53.0054Z","steps":["trace[38650963] 'agreement among raft nodes before linearized reading' (duration: 208.777599ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T21:59:53.457772Z","caller":"traceutil/trace.go:171","msg":"trace[39429574] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"310.241534ms","start":"2026-10-07T21:59:53.147503Z","end":"2026-10-07T21:59:53.457744Z","steps":["trace[39429574] 'process raft request' (duration: 310.054566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T21:59:53.458084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T21:59:53.147479Z","time spent":"310.394901ms","remote":"127.0.0.1:44082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3726,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T21:59:53.458309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.86341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T21:59:53.458371Z","caller":"traceutil/trace.go:171","msg":"trace[1878004676] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1912; }","duration":"167.019106ms","start":"2026-10-07T21:59:53.291339Z","end":"2026-10-07T21:59:53.458358Z","steps":["trace[1878004676] 'agreement among raft nodes before linearized reading' (duration: 166.87499ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T21:59:53.458173Z","caller":"traceutil/trace.go:171","msg":"trace[746473241] linearizableReadLoop","detail":"{readStateIndex:1987; appliedIndex:1987; }","duration":"166.666841ms","start":"2026-10-07T21:59:53.291418Z","end":"2026-10-07T21:59:53.458085Z","steps":["trace[746473241] 'read index received' (duration: 166.65644ms)","trace[746473241] 'applied index is now lower than readState.Index' (duration: 7.581µs)"],"step_count":2} {"level":"warn","ts":"2026-10-07T21:59:53.45889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.085762ms","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-07T21:59:53.458924Z","caller":"traceutil/trace.go:171","msg":"trace[688932778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1912; }","duration":"107.160426ms","start":"2026-10-07T21:59:53.351753Z","end":"2026-10-07T21:59:53.458914Z","steps":["trace[688932778] 'agreement among raft nodes before linearized reading' (duration: 106.995998ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:00:07.83182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.862725ms","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-07T22:00:07.831897Z","caller":"traceutil/trace.go:171","msg":"trace[50000205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2025; }","duration":"237.969149ms","start":"2026-10-07T22:00:07.59391Z","end":"2026-10-07T22:00:07.83188Z","steps":["trace[50000205] 'range keys from in-memory index tree' (duration: 237.73775ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:00:07.831829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.89626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T22:00:07.832101Z","caller":"traceutil/trace.go:171","msg":"trace[515101474] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2025; }","duration":"259.12207ms","start":"2026-10-07T22:00:07.572893Z","end":"2026-10-07T22:00:07.832015Z","steps":["trace[515101474] 'range keys from in-memory index tree' (duration: 258.847238ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:00:07.832347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.11298ms","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-07T22:00:07.832436Z","caller":"traceutil/trace.go:171","msg":"trace[440688212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2025; }","duration":"263.209204ms","start":"2026-10-07T22:00:07.569207Z","end":"2026-10-07T22:00:07.832416Z","steps":["trace[440688212] 'range keys from in-memory index tree' (duration: 262.956903ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:00:07.832973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.639504ms","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-10-07T22:00:07.833032Z","caller":"traceutil/trace.go:171","msg":"trace[1258064674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2025; }","duration":"244.749767ms","start":"2026-10-07T22:00:07.588269Z","end":"2026-10-07T22:00:07.833019Z","steps":["trace[1258064674] 'range keys from in-memory index tree' (duration: 243.588498ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:00:28.100987Z","caller":"traceutil/trace.go:171","msg":"trace[793302090] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"110.103536ms","start":"2026-10-07T22:00:27.990766Z","end":"2026-10-07T22:00:28.10087Z","steps":["trace[793302090] 'process raft request' (duration: 109.360957ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:00:28.404208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.833625ms","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-07T22:00:28.404304Z","caller":"traceutil/trace.go:171","msg":"trace[1617502538] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2155; }","duration":"101.968681ms","start":"2026-10-07T22:00:28.30231Z","end":"2026-10-07T22:00:28.404279Z","steps":["trace[1617502538] 'range keys from in-memory index tree' (duration: 101.644109ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:00:28.404481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.444905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-07T22:00:28.40457Z","caller":"traceutil/trace.go:171","msg":"trace[2035677367] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2155; }","duration":"123.57961ms","start":"2026-10-07T22:00:28.280969Z","end":"2026-10-07T22:00:28.404549Z","steps":["trace[2035677367] 'range keys from in-memory index tree' (duration: 122.918014ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:00:28.716708Z","caller":"traceutil/trace.go:171","msg":"trace[1477988881] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"237.564952ms","start":"2026-10-07T22:00:28.479112Z","end":"2026-10-07T22:00:28.716677Z","steps":["trace[1477988881] 'process raft request' (duration: 237.350054ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:00:28.731185Z","caller":"traceutil/trace.go:171","msg":"trace[769728187] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"202.653902ms","start":"2026-10-07T22:00:28.528505Z","end":"2026-10-07T22:00:28.731159Z","steps":["trace[769728187] 'process raft request' (duration: 202.544398ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:00:28.73201Z","caller":"traceutil/trace.go:171","msg":"trace[1518038246] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"227.09491ms","start":"2026-10-07T22:00:28.504846Z","end":"2026-10-07T22:00:28.731941Z","steps":["trace[1518038246] 'process raft request' (duration: 226.058391ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:00:29.379943Z","caller":"traceutil/trace.go:171","msg":"trace[768178213] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"101.422382ms","start":"2026-10-07T22:00:29.278484Z","end":"2026-10-07T22:00:29.379906Z","steps":["trace[768178213] 'process raft request' (duration: 101.259046ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:02:09.63029Z","caller":"traceutil/trace.go:171","msg":"trace[1293870309] transaction","detail":"{read_only:false; response_revision:2733; number_of_response:1; }","duration":"106.493584ms","start":"2026-10-07T22:02:09.523744Z","end":"2026-10-07T22:02:09.630238Z","steps":["trace[1293870309] 'process raft request' (duration: 106.271208ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:02:19.248002Z","caller":"traceutil/trace.go:171","msg":"trace[1052440610] linearizableReadLoop","detail":"{readStateIndex:2947; appliedIndex:2946; }","duration":"226.85828ms","start":"2026-10-07T22:02:19.021115Z","end":"2026-10-07T22:02:19.247973Z","steps":["trace[1052440610] 'read index received' (duration: 226.603754ms)","trace[1052440610] 'applied index is now lower than readState.Index' (duration: 253.466µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:02:19.248307Z","caller":"traceutil/trace.go:171","msg":"trace[1470334908] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"230.339246ms","start":"2026-10-07T22:02:19.017952Z","end":"2026-10-07T22:02:19.248291Z","steps":["trace[1470334908] 'process raft request' (duration: 229.873004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:02:19.248535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.409493ms","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-07T22:02:19.248571Z","caller":"traceutil/trace.go:171","msg":"trace[375011804] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2839; }","duration":"227.478566ms","start":"2026-10-07T22:02:19.02108Z","end":"2026-10-07T22:02:19.248559Z","steps":["trace[375011804] 'agreement among raft nodes before linearized reading' (duration: 227.406804ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:02:19.352327Z","caller":"traceutil/trace.go:171","msg":"trace[475419665] transaction","detail":"{read_only:false; response_revision:2840; number_of_response:1; }","duration":"200.93613ms","start":"2026-10-07T22:02:19.151364Z","end":"2026-10-07T22:02:19.3523Z","steps":["trace[475419665] 'process raft request' (duration: 200.697505ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:02:19.352873Z","caller":"traceutil/trace.go:171","msg":"trace[122195093] linearizableReadLoop","detail":"{readStateIndex:2950; appliedIndex:2947; }","duration":"104.746736ms","start":"2026-10-07T22:02:19.248085Z","end":"2026-10-07T22:02:19.352832Z","steps":["trace[122195093] 'read index received' (duration: 103.962626ms)","trace[122195093] 'applied index is now lower than readState.Index' (duration: 781.929µs)"],"step_count":2} {"level":"warn","ts":"2026-10-07T22:02:19.353209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.101646ms","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-10-07T22:02:19.353262Z","caller":"traceutil/trace.go:171","msg":"trace[1654620041] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2842; }","duration":"276.221359ms","start":"2026-10-07T22:02:19.077026Z","end":"2026-10-07T22:02:19.353247Z","steps":["trace[1654620041] 'agreement among raft nodes before linearized reading' (duration: 276.039824ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:02:19.353386Z","caller":"traceutil/trace.go:171","msg":"trace[12275192] transaction","detail":"{read_only:false; response_revision:2842; number_of_response:1; }","duration":"199.066614ms","start":"2026-10-07T22:02:19.154288Z","end":"2026-10-07T22:02:19.353354Z","steps":["trace[12275192] 'process raft request' (duration: 198.273015ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:02:19.353475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.925585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-07T22:02:19.353511Z","caller":"traceutil/trace.go:171","msg":"trace[1137678334] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2842; }","duration":"217.020777ms","start":"2026-10-07T22:02:19.136479Z","end":"2026-10-07T22:02:19.3535Z","steps":["trace[1137678334] 'agreement among raft nodes before linearized reading' (duration: 216.960726ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:02:19.352621Z","caller":"traceutil/trace.go:171","msg":"trace[1947458966] transaction","detail":"{read_only:false; response_revision:2841; number_of_response:1; }","duration":"198.524491ms","start":"2026-10-07T22:02:19.154081Z","end":"2026-10-07T22:02:19.352605Z","steps":["trace[1947458966] 'process raft request' (duration: 198.167612ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:02:51.028225Z","caller":"traceutil/trace.go:171","msg":"trace[1258820472] linearizableReadLoop","detail":"{readStateIndex:3127; appliedIndex:3126; }","duration":"127.342691ms","start":"2026-10-07T22:02:50.900863Z","end":"2026-10-07T22:02:51.028205Z","steps":["trace[1258820472] 'read index received' (duration: 127.218538ms)","trace[1258820472] 'applied index is now lower than readState.Index' (duration: 123.463µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:02:51.028321Z","caller":"traceutil/trace.go:171","msg":"trace[887200361] transaction","detail":"{read_only:false; response_revision:3013; number_of_response:1; }","duration":"137.689094ms","start":"2026-10-07T22:02:50.890624Z","end":"2026-10-07T22:02:51.028313Z","steps":["trace[887200361] 'process raft request' (duration: 137.468709ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:02:51.02848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.605136ms","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-07T22:02:51.028508Z","caller":"traceutil/trace.go:171","msg":"trace[1059059900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3013; }","duration":"127.671008ms","start":"2026-10-07T22:02:50.90083Z","end":"2026-10-07T22:02:51.028501Z","steps":["trace[1059059900] 'agreement among raft nodes before linearized reading' (duration: 127.579386ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:02:51.028609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.161672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-07T22:02:51.028624Z","caller":"traceutil/trace.go:171","msg":"trace[489397945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3013; }","duration":"125.195502ms","start":"2026-10-07T22:02:50.903424Z","end":"2026-10-07T22:02:51.028619Z","steps":["trace[489397945] 'agreement among raft nodes before linearized reading' (duration: 125.150201ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:02:51.151635Z","caller":"traceutil/trace.go:171","msg":"trace[2122450984] transaction","detail":"{read_only:false; response_revision:3015; number_of_response:1; }","duration":"119.295314ms","start":"2026-10-07T22:02:51.032299Z","end":"2026-10-07T22:02:51.151594Z","steps":["trace[2122450984] 'process raft request' (duration: 119.188701ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:02:51.151853Z","caller":"traceutil/trace.go:171","msg":"trace[1314086574] transaction","detail":"{read_only:false; response_revision:3014; number_of_response:1; }","duration":"120.044191ms","start":"2026-10-07T22:02:51.031782Z","end":"2026-10-07T22:02:51.151826Z","steps":["trace[1314086574] 'process raft request' (duration: 114.963457ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:10.529121Z","caller":"traceutil/trace.go:171","msg":"trace[1241344192] transaction","detail":"{read_only:false; response_revision:5064; number_of_response:1; }","duration":"138.811288ms","start":"2026-10-07T22:07:10.390281Z","end":"2026-10-07T22:07:10.529092Z","steps":["trace[1241344192] 'process raft request' (duration: 138.505834ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:10.529431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.35547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-07T22:07:10.529423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.286499ms","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-07T22:07:10.529549Z","caller":"traceutil/trace.go:171","msg":"trace[253310753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5064; }","duration":"100.456261ms","start":"2026-10-07T22:07:10.429059Z","end":"2026-10-07T22:07:10.529515Z","steps":["trace[253310753] 'agreement among raft nodes before linearized reading' (duration: 100.027374ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:10.529563Z","caller":"traceutil/trace.go:171","msg":"trace[200655836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5064; }","duration":"100.506412ms","start":"2026-10-07T22:07:10.428992Z","end":"2026-10-07T22:07:10.529499Z","steps":["trace[200655836] 'agreement among raft nodes before linearized reading' (duration: 100.106716ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:10.54619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.356363ms","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-07T22:07:10.546275Z","caller":"traceutil/trace.go:171","msg":"trace[1803678230] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5067; }","duration":"116.468255ms","start":"2026-10-07T22:07:10.429783Z","end":"2026-10-07T22:07:10.546252Z","steps":["trace[1803678230] 'agreement among raft nodes before linearized reading' (duration: 116.334773ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:16.909657Z","caller":"traceutil/trace.go:171","msg":"trace[530900714] linearizableReadLoop","detail":"{readStateIndex:5369; appliedIndex:5368; }","duration":"121.981496ms","start":"2026-10-07T22:07:16.787647Z","end":"2026-10-07T22:07:16.909629Z","steps":["trace[530900714] 'read index received' (duration: 121.753373ms)","trace[530900714] 'applied index is now lower than readState.Index' (duration: 226.483µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:07:16.909771Z","caller":"traceutil/trace.go:171","msg":"trace[432171628] transaction","detail":"{read_only:false; response_revision:5173; number_of_response:1; }","duration":"156.039005ms","start":"2026-10-07T22:07:16.753689Z","end":"2026-10-07T22:07:16.909728Z","steps":["trace[432171628] 'process raft request' (duration: 155.73709ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:16.91085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.176695ms","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-10-07T22:07:16.910914Z","caller":"traceutil/trace.go:171","msg":"trace[1973842937] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5173; }","duration":"123.292697ms","start":"2026-10-07T22:07:16.787604Z","end":"2026-10-07T22:07:16.910897Z","steps":["trace[1973842937] 'agreement among raft nodes before linearized reading' (duration: 122.138319ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:17.539028Z","caller":"traceutil/trace.go:171","msg":"trace[269347252] linearizableReadLoop","detail":"{readStateIndex:5373; appliedIndex:5371; }","duration":"174.235171ms","start":"2026-10-07T22:07:17.364762Z","end":"2026-10-07T22:07:17.538997Z","steps":["trace[269347252] 'read index received' (duration: 123.414459ms)","trace[269347252] 'applied index is now lower than readState.Index' (duration: 50.819432ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T22:07:17.539101Z","caller":"traceutil/trace.go:171","msg":"trace[160625001] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"215.877998ms","start":"2026-10-07T22:07:17.323179Z","end":"2026-10-07T22:07:17.539057Z","steps":["trace[160625001] 'process raft request' (duration: 215.616964ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:17.539466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.677178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-10-07T22:07:17.53965Z","caller":"traceutil/trace.go:171","msg":"trace[176737249] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5176; }","duration":"174.889241ms","start":"2026-10-07T22:07:17.364737Z","end":"2026-10-07T22:07:17.539626Z","steps":["trace[176737249] 'agreement among raft nodes before linearized reading' (duration: 174.481785ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:17.557332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.877216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9c280fa0-0ce9-45e2-9b00-bd921ba43eeb\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-07T22:07:17.557445Z","caller":"traceutil/trace.go:171","msg":"trace[860297461] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9c280fa0-0ce9-45e2-9b00-bd921ba43eeb; range_end:; response_count:1; response_revision:5177; }","duration":"150.045159ms","start":"2026-10-07T22:07:17.407376Z","end":"2026-10-07T22:07:17.557421Z","steps":["trace[860297461] 'agreement among raft nodes before linearized reading' (duration: 149.712324ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:17.650452Z","caller":"traceutil/trace.go:171","msg":"trace[89647860] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"102.915025ms","start":"2026-10-07T22:07:17.547513Z","end":"2026-10-07T22:07:17.650428Z","steps":["trace[89647860] 'process raft request' (duration: 95.62928ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:17.650841Z","caller":"traceutil/trace.go:171","msg":"trace[1498970464] transaction","detail":"{read_only:false; response_revision:5179; number_of_response:1; }","duration":"103.286471ms","start":"2026-10-07T22:07:17.547541Z","end":"2026-10-07T22:07:17.650827Z","steps":["trace[1498970464] 'process raft request' (duration: 102.830994ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:17.650978Z","caller":"traceutil/trace.go:171","msg":"trace[915774042] transaction","detail":"{read_only:false; response_revision:5180; number_of_response:1; }","duration":"101.883829ms","start":"2026-10-07T22:07:17.549074Z","end":"2026-10-07T22:07:17.650958Z","steps":["trace[915774042] 'process raft request' (duration: 101.600365ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:17.651253Z","caller":"traceutil/trace.go:171","msg":"trace[1404463003] transaction","detail":"{read_only:false; response_revision:5181; number_of_response:1; }","duration":"102.172194ms","start":"2026-10-07T22:07:17.549071Z","end":"2026-10-07T22:07:17.651243Z","steps":["trace[1404463003] 'process raft request' (duration: 101.831358ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:17.651481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.375245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-e7aea103-2acb-4f7c-be52-4ce2a59e052a\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-10-07T22:07:17.651539Z","caller":"traceutil/trace.go:171","msg":"trace[1456294898] range","detail":"{range_begin:/registry/persistentvolumes/pvc-e7aea103-2acb-4f7c-be52-4ce2a59e052a; range_end:; response_count:1; response_revision:5181; }","duration":"107.496397ms","start":"2026-10-07T22:07:17.544026Z","end":"2026-10-07T22:07:17.651522Z","steps":["trace[1456294898] 'agreement among raft nodes before linearized reading' (duration: 107.323594ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:17.651684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.134665ms","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-07T22:07:17.651746Z","caller":"traceutil/trace.go:171","msg":"trace[536932897] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5181; }","duration":"111.245296ms","start":"2026-10-07T22:07:17.540482Z","end":"2026-10-07T22:07:17.651727Z","steps":["trace[536932897] 'agreement among raft nodes before linearized reading' (duration: 111.085924ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:24.759858Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2869} {"level":"info","ts":"2026-10-07T22:07:24.862195Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2869,"took":"96.737723ms","hash":169180638,"current-db-size-bytes":51699712,"current-db-size":"52 MB","current-db-size-in-use-bytes":26931200,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-07T22:07:24.862279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":169180638,"revision":2869,"compact-revision":-1} {"level":"info","ts":"2026-10-07T22:07:30.486038Z","caller":"traceutil/trace.go:171","msg":"trace[940297345] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"373.420781ms","start":"2026-10-07T22:07:30.112586Z","end":"2026-10-07T22:07:30.486006Z","steps":["trace[940297345] 'process raft request' (duration: 373.224418ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:30.486325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:07:30.112564Z","time spent":"373.656516ms","remote":"127.0.0.1:44194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1603,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:07:30.494455Z","caller":"traceutil/trace.go:171","msg":"trace[425161005] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"380.739336ms","start":"2026-10-07T22:07:30.113677Z","end":"2026-10-07T22:07:30.494417Z","steps":["trace[425161005] 'process raft request' (duration: 380.408451ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T22:07:30.494499Z","caller":"traceutil/trace.go:171","msg":"trace[817854294] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"378.580182ms","start":"2026-10-07T22:07:30.115888Z","end":"2026-10-07T22:07:30.494468Z","steps":["trace[817854294] 'process raft request' (duration: 378.352358ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T22:07:30.49469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:07:30.115876Z","time spent":"378.685094ms","remote":"127.0.0.1:44194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1619,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T22:07:30.49469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T22:07:30.113665Z","time spent":"380.888438ms","remote":"127.0.0.1:44194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1411,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T22:12:24.766962Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5302} {"level":"info","ts":"2026-10-07T22:12:24.874122Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5302,"took":"105.674016ms","hash":498610173,"current-db-size-bytes":51699712,"current-db-size":"52 MB","current-db-size-in-use-bytes":19369984,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-07T22:12:24.874312Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":498610173,"revision":5302,"compact-revision":2869}