{"level":"warn","ts":"2026-09-16T02:11:28.679172Z","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-16T02:11:28.679273Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.118:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.118:2380","--initial-cluster=instance=https://162.253.55.118:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.118:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.118:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-16T02:11:28.679352Z","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-16T02:11:28.679367Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.118:2380"]} {"level":"info","ts":"2026-09-16T02:11:28.679389Z","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-16T02:11:28.68309Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"]} {"level":"info","ts":"2026-09-16T02:11:28.683282Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.118:2380"],"listen-peer-urls":["https://162.253.55.118:2380"],"advertise-client-urls":["https://162.253.55.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.118:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-16T02:11:28.689555Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.933344ms"} {"level":"info","ts":"2026-09-16T02:11:28.696183Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39c975536cfc1086","cluster-id":"ac0a95643fc422f0"} {"level":"info","ts":"2026-09-16T02:11:28.696267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=()"} {"level":"info","ts":"2026-09-16T02:11:28.696297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became follower at term 0"} {"level":"info","ts":"2026-09-16T02:11:28.696318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39c975536cfc1086 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-16T02:11:28.696328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became follower at term 1"} {"level":"info","ts":"2026-09-16T02:11:28.696418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=(4163988331651928198)"} {"level":"warn","ts":"2026-09-16T02:11:28.7033Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-16T02:11:28.706225Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-16T02:11:28.71094Z","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-16T02:11:28.713718Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39c975536cfc1086","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-16T02:11:28.714843Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39c975536cfc1086","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-16T02:11:28.715137Z","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-16T02:11:28.715176Z","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-16T02:11:28.715187Z","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-16T02:11:28.715761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=(4163988331651928198)"} {"level":"info","ts":"2026-09-16T02:11:28.71593Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ac0a95643fc422f0","local-member-id":"39c975536cfc1086","added-peer-id":"39c975536cfc1086","added-peer-peer-urls":["https://162.253.55.118:2380"]} {"level":"info","ts":"2026-09-16T02:11:28.71708Z","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-16T02:11:28.717527Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39c975536cfc1086","initial-advertise-peer-urls":["https://162.253.55.118:2380"],"listen-peer-urls":["https://162.253.55.118:2380"],"advertise-client-urls":["https://162.253.55.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-16T02:11:28.717562Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-16T02:11:28.717769Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.118:2380"} {"level":"info","ts":"2026-09-16T02:11:28.717784Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.118:2380"} {"level":"info","ts":"2026-09-16T02:11:28.996806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 is starting a new election at term 1"} {"level":"info","ts":"2026-09-16T02:11:28.996893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-16T02:11:28.996914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 received MsgPreVoteResp from 39c975536cfc1086 at term 1"} {"level":"info","ts":"2026-09-16T02:11:28.99693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became candidate at term 2"} {"level":"info","ts":"2026-09-16T02:11:28.996938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 received MsgVoteResp from 39c975536cfc1086 at term 2"} {"level":"info","ts":"2026-09-16T02:11:28.99695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became leader at term 2"} {"level":"info","ts":"2026-09-16T02:11:28.99696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39c975536cfc1086 elected leader 39c975536cfc1086 at term 2"} {"level":"info","ts":"2026-09-16T02:11:29.016569Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39c975536cfc1086","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.118:2379]}","request-path":"/0/members/39c975536cfc1086/attributes","cluster-id":"ac0a95643fc422f0","publish-timeout":"7s"} {"level":"info","ts":"2026-09-16T02:11:29.016616Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-16T02:11:29.016947Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T02:11:29.017235Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-16T02:11:29.01734Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-16T02:11:29.016637Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-16T02:11:29.019264Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.118:2379"} {"level":"info","ts":"2026-09-16T02:11:29.02054Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-16T02:11:29.026872Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ac0a95643fc422f0","local-member-id":"39c975536cfc1086","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T02:11:29.02698Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T02:11:29.027012Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-09-16T02:11:39.728195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.421183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-16T02:11:39.728428Z","caller":"traceutil/trace.go:171","msg":"trace[960553864] linearizableReadLoop","detail":"{readStateIndex:354; appliedIndex:351; }","duration":"152.593403ms","start":"2026-09-16T02:11:39.57582Z","end":"2026-09-16T02:11:39.728413Z","steps":["trace[960553864] 'read index received' (duration: 4.591709ms)","trace[960553864] 'applied index is now lower than readState.Index' (duration: 148.000914ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T02:11:39.728505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.679654ms","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-16T02:11:39.728527Z","caller":"traceutil/trace.go:171","msg":"trace[1996157118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:342; }","duration":"152.756074ms","start":"2026-09-16T02:11:39.575765Z","end":"2026-09-16T02:11:39.728521Z","steps":["trace[1996157118] 'agreement among raft nodes before linearized reading' (duration: 152.692203ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:11:39.728763Z","caller":"traceutil/trace.go:171","msg":"trace[1882400287] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"275.030734ms","start":"2026-09-16T02:11:39.45372Z","end":"2026-09-16T02:11:39.72875Z","steps":["trace[1882400287] 'process raft request' (duration: 126.670268ms)","trace[1882400287] 'compare' (duration: 147.226921ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:11:39.728868Z","caller":"traceutil/trace.go:171","msg":"trace[1831372338] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"274.798192ms","start":"2026-09-16T02:11:39.454064Z","end":"2026-09-16T02:11:39.728862Z","steps":["trace[1831372338] 'process raft request' (duration: 274.25998ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:11:39.72902Z","caller":"traceutil/trace.go:171","msg":"trace[1816951269] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"266.83449ms","start":"2026-09-16T02:11:39.462179Z","end":"2026-09-16T02:11:39.729014Z","steps":["trace[1816951269] 'process raft request' (duration: 266.192647ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:03.276193Z","caller":"traceutil/trace.go:171","msg":"trace[414145554] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"173.928457ms","start":"2026-09-16T02:12:03.101985Z","end":"2026-09-16T02:12:03.275913Z","steps":["trace[414145554] 'process raft request' (duration: 173.683746ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:17.587339Z","caller":"traceutil/trace.go:171","msg":"trace[230747123] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"235.381288ms","start":"2026-09-16T02:12:17.351908Z","end":"2026-09-16T02:12:17.587289Z","steps":["trace[230747123] 'process raft request' (duration: 235.071667ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:24.430841Z","caller":"traceutil/trace.go:171","msg":"trace[1215616896] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"183.135648ms","start":"2026-09-16T02:12:24.247669Z","end":"2026-09-16T02:12:24.430805Z","steps":["trace[1215616896] 'process raft request' (duration: 182.914117ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:24.870139Z","caller":"traceutil/trace.go:171","msg":"trace[875266796] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"365.202611ms","start":"2026-09-16T02:12:24.504896Z","end":"2026-09-16T02:12:24.870099Z","steps":["trace[875266796] 'read index received' (duration: 363.899145ms)","trace[875266796] 'applied index is now lower than readState.Index' (duration: 1.302306ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:12:24.870245Z","caller":"traceutil/trace.go:171","msg":"trace[605200377] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"381.289075ms","start":"2026-09-16T02:12:24.488912Z","end":"2026-09-16T02:12:24.870201Z","steps":["trace[605200377] 'process raft request' (duration: 380.494592ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:24.870403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.800326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:12:24.870458Z","caller":"traceutil/trace.go:171","msg":"trace[1498658098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"353.919396ms","start":"2026-09-16T02:12:24.516523Z","end":"2026-09-16T02:12:24.870442Z","steps":["trace[1498658098] 'agreement among raft nodes before linearized reading' (duration: 353.804336ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:24.870493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:12:24.516501Z","time spent":"353.984366ms","remote":"127.0.0.1:57004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-16T02:12:24.8707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.779263ms","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-16T02:12:24.87085Z","caller":"traceutil/trace.go:171","msg":"trace[1627709724] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"366.001734ms","start":"2026-09-16T02:12:24.504819Z","end":"2026-09-16T02:12:24.870821Z","steps":["trace[1627709724] 'agreement among raft nodes before linearized reading' (duration: 365.470362ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:24.870983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:12:24.504786Z","time spent":"366.100235ms","remote":"127.0.0.1:57292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-16T02:12:24.871077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:12:24.488353Z","time spent":"382.002028ms","remote":"127.0.0.1:57126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-16T02:12:25.099769Z","caller":"traceutil/trace.go:171","msg":"trace[257478113] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"221.256349ms","start":"2026-09-16T02:12:24.878464Z","end":"2026-09-16T02:12:25.099721Z","steps":["trace[257478113] 'process raft request' (duration: 167.443215ms)","trace[257478113] 'compare' (duration: 53.332952ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:12:25.099857Z","caller":"traceutil/trace.go:171","msg":"trace[116648442] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"149.872315ms","start":"2026-09-16T02:12:24.949948Z","end":"2026-09-16T02:12:25.09982Z","steps":["trace[116648442] 'process raft request' (duration: 149.648774ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:26.499152Z","caller":"traceutil/trace.go:171","msg":"trace[370495288] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"128.761941ms","start":"2026-09-16T02:12:26.370363Z","end":"2026-09-16T02:12:26.499125Z","steps":["trace[370495288] 'process raft request' (duration: 128.646821ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:12:26.504821Z","caller":"traceutil/trace.go:171","msg":"trace[224267344] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"134.443394ms","start":"2026-09-16T02:12:26.370364Z","end":"2026-09-16T02:12:26.504807Z","steps":["trace[224267344] 'process raft request' (duration: 134.376024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:12:41.095871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.596139ms","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-16T02:12:41.096036Z","caller":"traceutil/trace.go:171","msg":"trace[862453217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:788; }","duration":"100.860229ms","start":"2026-09-16T02:12:40.995154Z","end":"2026-09-16T02:12:41.096014Z","steps":["trace[862453217] 'range keys from in-memory index tree' (duration: 100.336517ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:13:12.634881Z","caller":"traceutil/trace.go:171","msg":"trace[1286928910] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"256.764373ms","start":"2026-09-16T02:13:12.378087Z","end":"2026-09-16T02:13:12.634851Z","steps":["trace[1286928910] 'process raft request' (duration: 255.813309ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:13:36.854748Z","caller":"traceutil/trace.go:171","msg":"trace[1877897595] transaction","detail":"{read_only:false; response_revision:1463; number_of_response:1; }","duration":"120.489294ms","start":"2026-09-16T02:13:36.734216Z","end":"2026-09-16T02:13:36.854705Z","steps":["trace[1877897595] 'process raft request' (duration: 120.284314ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:05.13653Z","caller":"traceutil/trace.go:171","msg":"trace[85734300] linearizableReadLoop","detail":"{readStateIndex:1968; appliedIndex:1967; }","duration":"215.67111ms","start":"2026-09-16T02:14:04.92083Z","end":"2026-09-16T02:14:05.136501Z","steps":["trace[85734300] 'read index received' (duration: 215.474139ms)","trace[85734300] 'applied index is now lower than readState.Index' (duration: 195.631µs)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:14:05.136689Z","caller":"traceutil/trace.go:171","msg":"trace[1506445026] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"335.600812ms","start":"2026-09-16T02:14:04.801076Z","end":"2026-09-16T02:14:05.136677Z","steps":["trace[1506445026] 'process raft request' (duration: 335.221141ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:14:05.136847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:14:04.801056Z","time spent":"335.661033ms","remote":"127.0.0.1:57212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-16T02:14:05.137193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.348692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-37261f7f-b47a-40d6-ac7b-46492830ccf5\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-09-16T02:14:05.137277Z","caller":"traceutil/trace.go:171","msg":"trace[1906648940] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-37261f7f-b47a-40d6-ac7b-46492830ccf5; range_end:; response_count:1; response_revision:1889; }","duration":"216.495333ms","start":"2026-09-16T02:14:04.920759Z","end":"2026-09-16T02:14:05.137254Z","steps":["trace[1906648940] 'agreement among raft nodes before linearized reading' (duration: 216.368842ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:05.438631Z","caller":"traceutil/trace.go:171","msg":"trace[1594108227] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"296.127477ms","start":"2026-09-16T02:14:05.142478Z","end":"2026-09-16T02:14:05.438606Z","steps":["trace[1594108227] 'process raft request' (duration: 295.968846ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:05.515351Z","caller":"traceutil/trace.go:171","msg":"trace[1546406940] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"372.664408ms","start":"2026-09-16T02:14:05.142662Z","end":"2026-09-16T02:14:05.515327Z","steps":["trace[1546406940] 'process raft request' (duration: 372.507467ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:14:05.515483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:14:05.142632Z","time spent":"372.777318ms","remote":"127.0.0.1:57292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-16T02:14:05.515766Z","caller":"traceutil/trace.go:171","msg":"trace[520684934] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"372.654567ms","start":"2026-09-16T02:14:05.14308Z","end":"2026-09-16T02:14:05.515735Z","steps":["trace[520684934] 'process raft request' (duration: 372.212176ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:14:05.515944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:14:05.143013Z","time spent":"372.833169ms","remote":"127.0.0.1:57292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-16T02:14:05.516118Z","caller":"traceutil/trace.go:171","msg":"trace[220633414] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"129.138449ms","start":"2026-09-16T02:14:05.386974Z","end":"2026-09-16T02:14:05.516112Z","steps":["trace[220633414] 'process raft request' (duration: 128.676237ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:14:05.784126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.353302ms","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-16T02:14:05.784275Z","caller":"traceutil/trace.go:171","msg":"trace[1591750698] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1893; }","duration":"145.582533ms","start":"2026-09-16T02:14:05.638663Z","end":"2026-09-16T02:14:05.784245Z","steps":["trace[1591750698] 'range keys from in-memory index tree' (duration: 145.048481ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:18.952285Z","caller":"traceutil/trace.go:171","msg":"trace[1603577815] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"283.656567ms","start":"2026-09-16T02:14:18.668609Z","end":"2026-09-16T02:14:18.952265Z","steps":["trace[1603577815] 'process raft request' (duration: 283.526397ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:35.924474Z","caller":"traceutil/trace.go:171","msg":"trace[521853404] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"234.504683ms","start":"2026-09-16T02:14:35.689946Z","end":"2026-09-16T02:14:35.924451Z","steps":["trace[521853404] 'process raft request' (duration: 234.343153ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:35.933048Z","caller":"traceutil/trace.go:171","msg":"trace[94900399] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"242.800336ms","start":"2026-09-16T02:14:35.690224Z","end":"2026-09-16T02:14:35.933024Z","steps":["trace[94900399] 'process raft request' (duration: 242.626495ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:36.472299Z","caller":"traceutil/trace.go:171","msg":"trace[1225203658] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"122.0665ms","start":"2026-09-16T02:14:36.350176Z","end":"2026-09-16T02:14:36.472242Z","steps":["trace[1225203658] 'process raft request' (duration: 121.771719ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:14:37.684075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.106459ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-16T02:14:37.786942Z","caller":"traceutil/trace.go:171","msg":"trace[955750934] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"108.149396ms","start":"2026-09-16T02:14:37.678768Z","end":"2026-09-16T02:14:37.786917Z","steps":["trace[955750934] 'process raft request' (duration: 107.983385ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:37.998753Z","caller":"traceutil/trace.go:171","msg":"trace[1938609191] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"187.242137ms","start":"2026-09-16T02:14:37.811456Z","end":"2026-09-16T02:14:37.998698Z","steps":["trace[1938609191] 'process raft request' (duration: 119.258929ms)","trace[1938609191] 'compare' (duration: 67.628227ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:14:38.135753Z","caller":"traceutil/trace.go:171","msg":"trace[1840728899] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"119.532301ms","start":"2026-09-16T02:14:38.016172Z","end":"2026-09-16T02:14:38.135704Z","steps":["trace[1840728899] 'process raft request' (duration: 118.955338ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:14:38.136013Z","caller":"traceutil/trace.go:171","msg":"trace[1586648115] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"119.29269ms","start":"2026-09-16T02:14:38.016702Z","end":"2026-09-16T02:14:38.135995Z","steps":["trace[1586648115] 'process raft request' (duration: 119.147569ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:16:34.84118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.100308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:16:34.841287Z","caller":"traceutil/trace.go:171","msg":"trace[547409752] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:2857; }","duration":"200.232398ms","start":"2026-09-16T02:16:34.641032Z","end":"2026-09-16T02:16:34.841265Z","steps":["trace[547409752] 'count revisions from in-memory index tree' (duration: 199.973638ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:16:35.009453Z","caller":"traceutil/trace.go:171","msg":"trace[1364459797] transaction","detail":"{read_only:false; response_revision:2858; number_of_response:1; }","duration":"163.626045ms","start":"2026-09-16T02:16:34.845799Z","end":"2026-09-16T02:16:35.009426Z","steps":["trace[1364459797] 'process raft request' (duration: 163.374394ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:16:35.009724Z","caller":"traceutil/trace.go:171","msg":"trace[915853543] linearizableReadLoop","detail":"{readStateIndex:2970; appliedIndex:2969; }","duration":"149.168317ms","start":"2026-09-16T02:16:34.860211Z","end":"2026-09-16T02:16:35.00938Z","steps":["trace[915853543] 'read index received' (duration: 148.843046ms)","trace[915853543] 'applied index is now lower than readState.Index' (duration: 324.131µs)"],"step_count":2} {"level":"warn","ts":"2026-09-16T02:16:35.0098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.548469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-16T02:16:35.0099Z","caller":"traceutil/trace.go:171","msg":"trace[1284765061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2858; }","duration":"149.701149ms","start":"2026-09-16T02:16:34.86018Z","end":"2026-09-16T02:16:35.009881Z","steps":["trace[1284765061] 'agreement among raft nodes before linearized reading' (duration: 149.383458ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:16:35.010058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.75503ms","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-16T02:16:35.010155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.220609ms","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-09-16T02:16:35.010224Z","caller":"traceutil/trace.go:171","msg":"trace[1111486622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2858; }","duration":"147.30891ms","start":"2026-09-16T02:16:34.862896Z","end":"2026-09-16T02:16:35.010205Z","steps":["trace[1111486622] 'agreement among raft nodes before linearized reading' (duration: 147.150389ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:16:35.010289Z","caller":"traceutil/trace.go:171","msg":"trace[1267867833] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2858; }","duration":"149.84286ms","start":"2026-09-16T02:16:34.860249Z","end":"2026-09-16T02:16:35.010092Z","steps":["trace[1267867833] 'agreement among raft nodes before linearized reading' (duration: 149.65789ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:16:35.202923Z","caller":"traceutil/trace.go:171","msg":"trace[1072984829] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"184.541866ms","start":"2026-09-16T02:16:35.018348Z","end":"2026-09-16T02:16:35.20289Z","steps":["trace[1072984829] 'process raft request' (duration: 152.196489ms)","trace[1072984829] 'compare' (duration: 32.222227ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:16:35.207964Z","caller":"traceutil/trace.go:171","msg":"trace[1248564899] transaction","detail":"{read_only:false; response_revision:2861; number_of_response:1; }","duration":"189.406116ms","start":"2026-09-16T02:16:35.01853Z","end":"2026-09-16T02:16:35.207937Z","steps":["trace[1248564899] 'process raft request' (duration: 189.255005ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:16:35.208006Z","caller":"traceutil/trace.go:171","msg":"trace[964054424] transaction","detail":"{read_only:false; response_revision:2862; number_of_response:1; }","duration":"186.638264ms","start":"2026-09-16T02:16:35.021347Z","end":"2026-09-16T02:16:35.207985Z","steps":["trace[964054424] 'process raft request' (duration: 186.488424ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:16:35.20819Z","caller":"traceutil/trace.go:171","msg":"trace[396077858] transaction","detail":"{read_only:false; response_revision:2860; number_of_response:1; }","duration":"189.475796ms","start":"2026-09-16T02:16:35.018396Z","end":"2026-09-16T02:16:35.207872Z","steps":["trace[396077858] 'process raft request' (duration: 189.192995ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:19:00.14059Z","caller":"traceutil/trace.go:171","msg":"trace[1851150179] transaction","detail":"{read_only:false; response_revision:3608; number_of_response:1; }","duration":"107.729054ms","start":"2026-09-16T02:19:00.031873Z","end":"2026-09-16T02:19:00.139602Z","steps":["trace[1851150179] 'process raft request' (duration: 49.956727ms)","trace[1851150179] 'compare' (duration: 57.159705ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:21:08.218811Z","caller":"traceutil/trace.go:171","msg":"trace[2077255352] linearizableReadLoop","detail":"{readStateIndex:5056; appliedIndex:5055; }","duration":"189.668646ms","start":"2026-09-16T02:21:08.029117Z","end":"2026-09-16T02:21:08.218785Z","steps":["trace[2077255352] 'read index received' (duration: 124.52278ms)","trace[2077255352] 'applied index is now lower than readState.Index' (duration: 65.144896ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:21:08.218919Z","caller":"traceutil/trace.go:171","msg":"trace[61276293] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"189.833397ms","start":"2026-09-16T02:21:08.029035Z","end":"2026-09-16T02:21:08.218868Z","steps":["trace[61276293] 'process raft request' (duration: 124.765771ms)","trace[61276293] 'compare' (duration: 64.805525ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T02:21:08.219151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.017648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-16T02:21:08.219204Z","caller":"traceutil/trace.go:171","msg":"trace[349689260] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4862; }","duration":"190.112458ms","start":"2026-09-16T02:21:08.029079Z","end":"2026-09-16T02:21:08.219192Z","steps":["trace[349689260] 'agreement among raft nodes before linearized reading' (duration: 189.806747ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.311808Z","caller":"traceutil/trace.go:171","msg":"trace[352353125] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"279.038649ms","start":"2026-09-16T02:21:08.03271Z","end":"2026-09-16T02:21:08.311749Z","steps":["trace[352353125] 'process raft request' (duration: 278.722567ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.312025Z","caller":"traceutil/trace.go:171","msg":"trace[1933477937] transaction","detail":"{read_only:false; response_revision:4864; number_of_response:1; }","duration":"196.803205ms","start":"2026-09-16T02:21:08.115201Z","end":"2026-09-16T02:21:08.312004Z","steps":["trace[1933477937] 'process raft request' (duration: 196.464823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:08.312253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.976134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-09-16T02:21:08.312344Z","caller":"traceutil/trace.go:171","msg":"trace[831114061] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4864; }","duration":"283.089545ms","start":"2026-09-16T02:21:08.029234Z","end":"2026-09-16T02:21:08.312323Z","steps":["trace[831114061] 'agreement among raft nodes before linearized reading' (duration: 282.788624ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.33394Z","caller":"traceutil/trace.go:171","msg":"trace[2133962541] transaction","detail":"{read_only:false; response_revision:4866; number_of_response:1; }","duration":"110.533065ms","start":"2026-09-16T02:21:08.223389Z","end":"2026-09-16T02:21:08.333922Z","steps":["trace[2133962541] 'process raft request' (duration: 110.415504ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.333941Z","caller":"traceutil/trace.go:171","msg":"trace[505651113] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"110.779826ms","start":"2026-09-16T02:21:08.223131Z","end":"2026-09-16T02:21:08.333911Z","steps":["trace[505651113] 'process raft request' (duration: 108.543677ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:08.334193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.20157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-16T02:21:08.335004Z","caller":"traceutil/trace.go:171","msg":"trace[1552998207] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4867; }","duration":"110.029693ms","start":"2026-09-16T02:21:08.224949Z","end":"2026-09-16T02:21:08.334979Z","steps":["trace[1552998207] 'agreement among raft nodes before linearized reading' (duration: 109.002369ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:08.334283Z","caller":"traceutil/trace.go:171","msg":"trace[1383998420] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"107.479143ms","start":"2026-09-16T02:21:08.22678Z","end":"2026-09-16T02:21:08.334259Z","steps":["trace[1383998420] 'process raft request' (duration: 107.089862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:21.781505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.141009ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:21:21.781763Z","caller":"traceutil/trace.go:171","msg":"trace[275510825] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5121; }","duration":"157.42704ms","start":"2026-09-16T02:21:21.624314Z","end":"2026-09-16T02:21:21.781741Z","steps":["trace[275510825] 'range keys from in-memory index tree' (duration: 157.118679ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:21.859587Z","caller":"traceutil/trace.go:171","msg":"trace[1278686212] linearizableReadLoop","detail":"{readStateIndex:5323; appliedIndex:5322; }","duration":"326.338875ms","start":"2026-09-16T02:21:21.533222Z","end":"2026-09-16T02:21:21.859561Z","steps":["trace[1278686212] 'read index received' (duration: 326.166964ms)","trace[1278686212] 'applied index is now lower than readState.Index' (duration: 170.851µs)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:21:21.859625Z","caller":"traceutil/trace.go:171","msg":"trace[726109704] transaction","detail":"{read_only:false; response_revision:5122; number_of_response:1; }","duration":"352.786069ms","start":"2026-09-16T02:21:21.506811Z","end":"2026-09-16T02:21:21.859597Z","steps":["trace[726109704] 'process raft request' (duration: 352.588978ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:21.859878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:21:21.506792Z","time spent":"353.0123ms","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2228,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-16T02:21:21.861154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.924031ms","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-16T02:21:21.861257Z","caller":"traceutil/trace.go:171","msg":"trace[1475472923] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5122; }","duration":"328.055732ms","start":"2026-09-16T02:21:21.533185Z","end":"2026-09-16T02:21:21.86124Z","steps":["trace[1475472923] 'agreement among raft nodes before linearized reading' (duration: 326.489466ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:21.861353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:21:21.533167Z","time spent":"328.168723ms","remote":"127.0.0.1:57130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2207441,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-09-16T02:21:21.873201Z","caller":"traceutil/trace.go:171","msg":"trace[1384612501] transaction","detail":"{read_only:false; response_revision:5123; number_of_response:1; }","duration":"277.638443ms","start":"2026-09-16T02:21:21.595536Z","end":"2026-09-16T02:21:21.873175Z","steps":["trace[1384612501] 'process raft request' (duration: 277.512713ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:22.350054Z","caller":"traceutil/trace.go:171","msg":"trace[1959994677] transaction","detail":"{read_only:false; response_revision:5126; number_of_response:1; }","duration":"238.65066ms","start":"2026-09-16T02:21:22.111374Z","end":"2026-09-16T02:21:22.350025Z","steps":["trace[1959994677] 'process raft request' (duration: 238.438469ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:22.387945Z","caller":"traceutil/trace.go:171","msg":"trace[932807757] linearizableReadLoop","detail":"{readStateIndex:5328; appliedIndex:5326; }","duration":"200.68114ms","start":"2026-09-16T02:21:22.187242Z","end":"2026-09-16T02:21:22.387923Z","steps":["trace[932807757] 'read index received' (duration: 162.53383ms)","trace[932807757] 'applied index is now lower than readState.Index' (duration: 38.14642ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T02:21:22.38816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.903411ms","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-09-16T02:21:22.388194Z","caller":"traceutil/trace.go:171","msg":"trace[665918648] 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:5127; }","duration":"200.954371ms","start":"2026-09-16T02:21:22.187226Z","end":"2026-09-16T02:21:22.388181Z","steps":["trace[665918648] 'agreement among raft nodes before linearized reading' (duration: 200.815831ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:22.388607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.774774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.118\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-16T02:21:22.388705Z","caller":"traceutil/trace.go:171","msg":"trace[2013988900] range","detail":"{range_begin:/registry/masterleases/162.253.55.118; range_end:; response_count:1; response_revision:5127; }","duration":"183.939974ms","start":"2026-09-16T02:21:22.204749Z","end":"2026-09-16T02:21:22.388689Z","steps":["trace[2013988900] 'agreement among raft nodes before linearized reading' (duration: 183.580743ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:22.389163Z","caller":"traceutil/trace.go:171","msg":"trace[1117415964] transaction","detail":"{read_only:false; response_revision:5127; number_of_response:1; }","duration":"261.335859ms","start":"2026-09-16T02:21:22.126771Z","end":"2026-09-16T02:21:22.388106Z","steps":["trace[1117415964] 'process raft request' (duration: 260.987948ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:29.04434Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2831} {"level":"info","ts":"2026-09-16T02:21:29.122348Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2831,"took":"76.800632ms","hash":182513481,"current-db-size-bytes":51605504,"current-db-size":"52 MB","current-db-size-in-use-bytes":27172864,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-16T02:21:29.1224Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":182513481,"revision":2831,"compact-revision":-1} {"level":"warn","ts":"2026-09-16T02:21:35.847429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.603714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T02:21:35.847512Z","caller":"traceutil/trace.go:171","msg":"trace[1752739059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5302; }","duration":"328.837965ms","start":"2026-09-16T02:21:35.518655Z","end":"2026-09-16T02:21:35.847493Z","steps":["trace[1752739059] 'range keys from in-memory index tree' (duration: 328.521623ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:35.847572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T02:21:35.518635Z","time spent":"328.927265ms","remote":"127.0.0.1:57006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-16T02:21:36.449266Z","caller":"traceutil/trace.go:171","msg":"trace[1695016370] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"120.174893ms","start":"2026-09-16T02:21:36.329038Z","end":"2026-09-16T02:21:36.449213Z","steps":["trace[1695016370] 'process raft request' (duration: 120.110413ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:36.449284Z","caller":"traceutil/trace.go:171","msg":"trace[633678784] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"120.185183ms","start":"2026-09-16T02:21:36.329066Z","end":"2026-09-16T02:21:36.449251Z","steps":["trace[633678784] 'process raft request' (duration: 119.962293ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:36.449437Z","caller":"traceutil/trace.go:171","msg":"trace[1300059207] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"119.559231ms","start":"2026-09-16T02:21:36.329857Z","end":"2026-09-16T02:21:36.449416Z","steps":["trace[1300059207] 'process raft request' (duration: 119.33105ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:21:36.449553Z","caller":"traceutil/trace.go:171","msg":"trace[1111477612] linearizableReadLoop","detail":"{readStateIndex:5517; appliedIndex:5514; }","duration":"119.830012ms","start":"2026-09-16T02:21:36.329701Z","end":"2026-09-16T02:21:36.449531Z","steps":["trace[1111477612] 'read index received' (duration: 21.079313ms)","trace[1111477612] 'applied index is now lower than readState.Index' (duration: 98.748798ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:21:36.449626Z","caller":"traceutil/trace.go:171","msg":"trace[10912440] transaction","detail":"{read_only:false; response_revision:5311; number_of_response:1; }","duration":"104.16164ms","start":"2026-09-16T02:21:36.345454Z","end":"2026-09-16T02:21:36.449616Z","steps":["trace[10912440] 'process raft request' (duration: 103.884779ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T02:21:36.450261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.029282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-d4b4b62a-e6d1-40c0-95cb-655b752fcca1\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-09-16T02:21:36.450339Z","caller":"traceutil/trace.go:171","msg":"trace[2007987139] range","detail":"{range_begin:/registry/persistentvolumes/pvc-d4b4b62a-e6d1-40c0-95cb-655b752fcca1; range_end:; response_count:1; response_revision:5311; }","duration":"120.641075ms","start":"2026-09-16T02:21:36.329674Z","end":"2026-09-16T02:21:36.450315Z","steps":["trace[2007987139] 'agreement among raft nodes before linearized reading' (duration: 119.934782ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T02:22:26.392769Z","caller":"traceutil/trace.go:171","msg":"trace[1368195183] transaction","detail":"{read_only:false; response_revision:5738; number_of_response:1; }","duration":"159.395348ms","start":"2026-09-16T02:22:26.233351Z","end":"2026-09-16T02:22:26.392746Z","steps":["trace[1368195183] 'process raft request' (duration: 60.621089ms)","trace[1368195183] 'compare' (duration: 98.682658ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T02:26:29.050887Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5249} {"level":"info","ts":"2026-09-16T02:26:29.13838Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5249,"took":"85.966075ms","hash":2282816129,"current-db-size-bytes":51605504,"current-db-size":"52 MB","current-db-size-in-use-bytes":19263488,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-16T02:26:29.138462Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2282816129,"revision":5249,"compact-revision":2831}