{"level":"warn","ts":"2026-10-13T12:32:42.45782Z","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-13T12:32:42.457892Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.72: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.72:2380","--initial-cluster=instance=https://162.253.55.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.72: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-13T12:32:42.457947Z","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-13T12:32:42.457958Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.72:2380"]} {"level":"info","ts":"2026-10-13T12:32:42.457974Z","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-13T12:32:42.458635Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.72:2379"]} {"level":"info","ts":"2026-10-13T12:32:42.458707Z","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.72:2380"],"listen-peer-urls":["https://162.253.55.72:2380"],"advertise-client-urls":["https://162.253.55.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.72: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-13T12:32:42.463518Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.610457ms"} {"level":"info","ts":"2026-10-13T12:32:42.469707Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"638d1b11488f2a2e","cluster-id":"9ca31ccb1db898d"} {"level":"info","ts":"2026-10-13T12:32:42.469774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T12:32:42.469795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became follower at term 0"} {"level":"info","ts":"2026-10-13T12:32:42.469804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 638d1b11488f2a2e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T12:32:42.469812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became follower at term 1"} {"level":"info","ts":"2026-10-13T12:32:42.469849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e switched to configuration voters=(7173419542516804142)"} {"level":"warn","ts":"2026-10-13T12:32:42.47846Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T12:32:42.48035Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T12:32:42.483347Z","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-13T12:32:42.485393Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"638d1b11488f2a2e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T12:32:42.485588Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"638d1b11488f2a2e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T12:32:42.485674Z","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-13T12:32:42.486116Z","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-13T12:32:42.486127Z","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-13T12:32:42.487824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e switched to configuration voters=(7173419542516804142)"} {"level":"info","ts":"2026-10-13T12:32:42.487914Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ca31ccb1db898d","local-member-id":"638d1b11488f2a2e","added-peer-id":"638d1b11488f2a2e","added-peer-peer-urls":["https://162.253.55.72:2380"]} {"level":"info","ts":"2026-10-13T12:32:42.489828Z","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-13T12:32:42.48987Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.72:2380"} {"level":"info","ts":"2026-10-13T12:32:42.490063Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.72:2380"} {"level":"info","ts":"2026-10-13T12:32:42.491528Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"638d1b11488f2a2e","initial-advertise-peer-urls":["https://162.253.55.72:2380"],"listen-peer-urls":["https://162.253.55.72:2380"],"advertise-client-urls":["https://162.253.55.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T12:32:42.491571Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T12:32:42.775388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T12:32:42.775457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T12:32:42.775481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e received MsgPreVoteResp from 638d1b11488f2a2e at term 1"} {"level":"info","ts":"2026-10-13T12:32:42.775497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became candidate at term 2"} {"level":"info","ts":"2026-10-13T12:32:42.775504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e received MsgVoteResp from 638d1b11488f2a2e at term 2"} {"level":"info","ts":"2026-10-13T12:32:42.775642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became leader at term 2"} {"level":"info","ts":"2026-10-13T12:32:42.775663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 638d1b11488f2a2e elected leader 638d1b11488f2a2e at term 2"} {"level":"info","ts":"2026-10-13T12:32:42.779955Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"638d1b11488f2a2e","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.72:2379]}","request-path":"/0/members/638d1b11488f2a2e/attributes","cluster-id":"9ca31ccb1db898d","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T12:32:42.780493Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T12:32:42.78057Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T12:32:42.780692Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T12:32:42.781577Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T12:32:42.781629Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T12:32:42.784475Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-13T12:32:42.784672Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ca31ccb1db898d","local-member-id":"638d1b11488f2a2e","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T12:32:42.784798Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T12:32:42.784878Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T12:32:42.792797Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.72:2379"} {"level":"info","ts":"2026-10-13T12:32:47.817034Z","caller":"traceutil/trace.go:171","msg":"trace[2134640034] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"356.430403ms","start":"2026-10-13T12:32:47.460561Z","end":"2026-10-13T12:32:47.816991Z","steps":["trace[2134640034] 'process raft request' (duration: 356.269749ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:32:47.818549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T12:32:47.460541Z","time spent":"356.583147ms","remote":"127.0.0.1:44342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T12:32:48.043256Z","caller":"traceutil/trace.go:171","msg":"trace[1621200801] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"218.509515ms","start":"2026-10-13T12:32:47.824721Z","end":"2026-10-13T12:32:48.04323Z","steps":["trace[1621200801] 'process raft request' (duration: 212.151643ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:32:48.043846Z","caller":"traceutil/trace.go:171","msg":"trace[1187192735] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"139.887568ms","start":"2026-10-13T12:32:47.903943Z","end":"2026-10-13T12:32:48.043831Z","steps":["trace[1187192735] 'process raft request' (duration: 139.824436ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:33:24.871016Z","caller":"traceutil/trace.go:171","msg":"trace[750240941] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"253.012657ms","start":"2026-10-13T12:33:24.617981Z","end":"2026-10-13T12:33:24.870994Z","steps":["trace[750240941] 'process raft request' (duration: 252.916256ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:33:24.871024Z","caller":"traceutil/trace.go:171","msg":"trace[394332243] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"254.550324ms","start":"2026-10-13T12:33:24.616449Z","end":"2026-10-13T12:33:24.871Z","steps":["trace[394332243] 'process raft request' (duration: 251.638833ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:33:24.876543Z","caller":"traceutil/trace.go:171","msg":"trace[2072099913] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"252.100601ms","start":"2026-10-13T12:33:24.624427Z","end":"2026-10-13T12:33:24.876528Z","steps":["trace[2072099913] 'process raft request' (duration: 251.921587ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:33:31.327926Z","caller":"traceutil/trace.go:171","msg":"trace[1919029962] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"136.552966ms","start":"2026-10-13T12:33:31.19135Z","end":"2026-10-13T12:33:31.327903Z","steps":["trace[1919029962] 'process raft request' (duration: 136.002037ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:33:31.550999Z","caller":"traceutil/trace.go:171","msg":"trace[908580739] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"152.02074ms","start":"2026-10-13T12:33:31.398954Z","end":"2026-10-13T12:33:31.550975Z","steps":["trace[908580739] 'process raft request' (duration: 151.781515ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:33:32.15206Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3039544048604146274,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-13T12:33:32.200434Z","caller":"traceutil/trace.go:171","msg":"trace[2019666297] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"548.386425ms","start":"2026-10-13T12:33:31.652018Z","end":"2026-10-13T12:33:32.200405Z","steps":["trace[2019666297] 'read index received' (duration: 548.09035ms)","trace[2019666297] 'applied index is now lower than readState.Index' (duration: 295.315µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T12:33:32.20054Z","caller":"traceutil/trace.go:171","msg":"trace[327592881] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"591.449582ms","start":"2026-10-13T12:33:31.609066Z","end":"2026-10-13T12:33:32.200515Z","steps":["trace[327592881] 'process raft request' (duration: 591.132036ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:33:32.200666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T12:33:31.60905Z","time spent":"591.546863ms","remote":"127.0.0.1:44348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T12:33:32.20066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.634059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2kh77\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-13T12:33:32.200772Z","caller":"traceutil/trace.go:171","msg":"trace[559695358] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2kh77; range_end:; response_count:1; response_revision:649; }","duration":"548.800232ms","start":"2026-10-13T12:33:31.651954Z","end":"2026-10-13T12:33:32.200754Z","steps":["trace[559695358] 'agreement among raft nodes before linearized reading' (duration: 548.553918ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:33:32.200844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T12:33:31.651933Z","time spent":"548.899734ms","remote":"127.0.0.1:44348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-2kh77\" "} {"level":"info","ts":"2026-10-13T12:33:47.193353Z","caller":"traceutil/trace.go:171","msg":"trace[114058256] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"148.253429ms","start":"2026-10-13T12:33:47.045069Z","end":"2026-10-13T12:33:47.193322Z","steps":["trace[114058256] 'process raft request' (duration: 148.038916ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:33:47.398739Z","caller":"traceutil/trace.go:171","msg":"trace[98774140] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:839; }","duration":"148.554394ms","start":"2026-10-13T12:33:47.250154Z","end":"2026-10-13T12:33:47.398708Z","steps":["trace[98774140] 'read index received' (duration: 141.532982ms)","trace[98774140] 'applied index is now lower than readState.Index' (duration: 7.020122ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T12:33:47.398807Z","caller":"traceutil/trace.go:171","msg":"trace[173020890] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"201.368184ms","start":"2026-10-13T12:33:47.197419Z","end":"2026-10-13T12:33:47.398787Z","steps":["trace[173020890] 'process raft request' (duration: 194.303622ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:33:47.39889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.729326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T12:33:47.398934Z","caller":"traceutil/trace.go:171","msg":"trace[150471325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:812; }","duration":"148.825808ms","start":"2026-10-13T12:33:47.250095Z","end":"2026-10-13T12:33:47.398921Z","steps":["trace[150471325] 'agreement among raft nodes before linearized reading' (duration: 148.729877ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:34:41.478594Z","caller":"traceutil/trace.go:171","msg":"trace[2011958685] transaction","detail":"{read_only:false; response_revision:1477; number_of_response:1; }","duration":"272.080887ms","start":"2026-10-13T12:34:41.206485Z","end":"2026-10-13T12:34:41.478566Z","steps":["trace[2011958685] 'process raft request' (duration: 271.925875ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:34:42.158714Z","caller":"traceutil/trace.go:171","msg":"trace[1391854017] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"129.247423ms","start":"2026-10-13T12:34:42.02944Z","end":"2026-10-13T12:34:42.158688Z","steps":["trace[1391854017] 'process raft request' (duration: 129.052071ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:35:00.069127Z","caller":"traceutil/trace.go:171","msg":"trace[742863082] transaction","detail":"{read_only:false; response_revision:1793; number_of_response:1; }","duration":"140.71783ms","start":"2026-10-13T12:34:59.928384Z","end":"2026-10-13T12:35:00.069102Z","steps":["trace[742863082] 'process raft request' (duration: 126.363842ms)","trace[742863082] 'compare' (duration: 14.195025ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T12:35:00.069275Z","caller":"traceutil/trace.go:171","msg":"trace[441896477] transaction","detail":"{read_only:false; response_revision:1794; number_of_response:1; }","duration":"139.801107ms","start":"2026-10-13T12:34:59.929443Z","end":"2026-10-13T12:35:00.069245Z","steps":["trace[441896477] 'process raft request' (duration: 139.614165ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:35:08.329469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.901137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4939748d-1df8-45d9-a137-bbbd7d355a8f\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-13T12:35:08.329568Z","caller":"traceutil/trace.go:171","msg":"trace[761230107] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4939748d-1df8-45d9-a137-bbbd7d355a8f; range_end:; response_count:1; response_revision:1906; }","duration":"379.02749ms","start":"2026-10-13T12:35:07.950518Z","end":"2026-10-13T12:35:08.329545Z","steps":["trace[761230107] 'range keys from in-memory index tree' (duration: 378.738065ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:35:08.329616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T12:35:07.950507Z","time spent":"379.09619ms","remote":"127.0.0.1:44348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4939748d-1df8-45d9-a137-bbbd7d355a8f\" "} {"level":"info","ts":"2026-10-13T12:35:08.345509Z","caller":"traceutil/trace.go:171","msg":"trace[903803543] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1979; }","duration":"231.210822ms","start":"2026-10-13T12:35:08.11427Z","end":"2026-10-13T12:35:08.34548Z","steps":["trace[903803543] 'read index received' (duration: 231.03897ms)","trace[903803543] 'applied index is now lower than readState.Index' (duration: 170.212µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T12:35:08.345559Z","caller":"traceutil/trace.go:171","msg":"trace[1842257707] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"235.556929ms","start":"2026-10-13T12:35:08.109978Z","end":"2026-10-13T12:35:08.345535Z","steps":["trace[1842257707] 'process raft request' (duration: 235.339786ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:35:08.345755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.477535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-13T12:35:08.345796Z","caller":"traceutil/trace.go:171","msg":"trace[674958112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1907; }","duration":"231.571097ms","start":"2026-10-13T12:35:08.114214Z","end":"2026-10-13T12:35:08.345785Z","steps":["trace[674958112] 'agreement among raft nodes before linearized reading' (duration: 231.409375ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:35:08.37086Z","caller":"traceutil/trace.go:171","msg":"trace[577827365] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"114.919872ms","start":"2026-10-13T12:35:08.255893Z","end":"2026-10-13T12:35:08.370813Z","steps":["trace[577827365] 'process raft request' (duration: 114.722449ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:35:08.3709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.397753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4939748d-1df8-45d9-a137-bbbd7d355a8f\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-13T12:35:08.37108Z","caller":"traceutil/trace.go:171","msg":"trace[1496752447] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4939748d-1df8-45d9-a137-bbbd7d355a8f; range_end:; response_count:1; response_revision:1909; }","duration":"220.603716ms","start":"2026-10-13T12:35:08.150461Z","end":"2026-10-13T12:35:08.371065Z","steps":["trace[1496752447] 'agreement among raft nodes before linearized reading' (duration: 220.294692ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:35:20.920125Z","caller":"traceutil/trace.go:171","msg":"trace[611431213] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"113.132667ms","start":"2026-10-13T12:35:20.806969Z","end":"2026-10-13T12:35:20.920101Z","steps":["trace[611431213] 'process raft request' (duration: 112.831653ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:35:21.489007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.124469ms","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-10-13T12:35:21.489145Z","caller":"traceutil/trace.go:171","msg":"trace[2091306027] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2015; }","duration":"260.269931ms","start":"2026-10-13T12:35:21.228851Z","end":"2026-10-13T12:35:21.489121Z","steps":["trace[2091306027] 'range keys from in-memory index tree' (duration: 260.109289ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:35:21.494345Z","caller":"traceutil/trace.go:171","msg":"trace[453449745] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"447.367084ms","start":"2026-10-13T12:35:21.04694Z","end":"2026-10-13T12:35:21.494307Z","steps":["trace[453449745] 'process raft request' (duration: 447.146941ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:35:21.494572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T12:35:21.046915Z","time spent":"447.529466ms","remote":"127.0.0.1:44424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T12:35:21.495125Z","caller":"traceutil/trace.go:171","msg":"trace[668212841] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"278.238669ms","start":"2026-10-13T12:35:21.216866Z","end":"2026-10-13T12:35:21.495105Z","steps":["trace[668212841] 'process raft request' (duration: 278.063267ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:35:42.848395Z","caller":"traceutil/trace.go:171","msg":"trace[371429950] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"302.256913ms","start":"2026-10-13T12:35:42.546104Z","end":"2026-10-13T12:35:42.848361Z","steps":["trace[371429950] 'process raft request' (duration: 222.045047ms)","trace[371429950] 'compare' (duration: 80.043754ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T12:35:42.848423Z","caller":"traceutil/trace.go:171","msg":"trace[387509257] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"226.948188ms","start":"2026-10-13T12:35:42.62146Z","end":"2026-10-13T12:35:42.848408Z","steps":["trace[387509257] 'process raft request' (duration: 226.882158ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:35:42.848509Z","caller":"traceutil/trace.go:171","msg":"trace[1576043239] linearizableReadLoop","detail":"{readStateIndex:2228; appliedIndex:2227; }","duration":"249.130413ms","start":"2026-10-13T12:35:42.599272Z","end":"2026-10-13T12:35:42.848402Z","steps":["trace[1576043239] 'read index received' (duration: 168.895927ms)","trace[1576043239] 'applied index is now lower than readState.Index' (duration: 80.232356ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T12:35:42.848608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T12:35:42.546091Z","time spent":"302.402304ms","remote":"127.0.0.1:44424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T12:35:42.848627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.324556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T12:35:42.848714Z","caller":"traceutil/trace.go:171","msg":"trace[659508674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2149; }","duration":"249.453467ms","start":"2026-10-13T12:35:42.599243Z","end":"2026-10-13T12:35:42.848697Z","steps":["trace[659508674] 'agreement among raft nodes before linearized reading' (duration: 249.293595ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:35:42.848776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.883319ms","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-13T12:35:42.848836Z","caller":"traceutil/trace.go:171","msg":"trace[1527322160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2149; }","duration":"211.013879ms","start":"2026-10-13T12:35:42.637804Z","end":"2026-10-13T12:35:42.848818Z","steps":["trace[1527322160] 'agreement among raft nodes before linearized reading' (duration: 210.836427ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:35:43.274416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.012929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-10-13T12:35:43.274454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.815383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-10-13T12:35:43.274551Z","caller":"traceutil/trace.go:171","msg":"trace[719251785] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2150; }","duration":"251.982626ms","start":"2026-10-13T12:35:43.022551Z","end":"2026-10-13T12:35:43.274534Z","steps":["trace[719251785] 'range keys from in-memory index tree' (duration: 251.622561ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:35:43.274555Z","caller":"traceutil/trace.go:171","msg":"trace[1548523884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2150; }","duration":"120.179521ms","start":"2026-10-13T12:35:43.154348Z","end":"2026-10-13T12:35:43.274528Z","steps":["trace[1548523884] 'range keys from in-memory index tree' (duration: 119.890988ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:35:43.27458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.075124ms","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-13T12:35:43.275155Z","caller":"traceutil/trace.go:171","msg":"trace[1149697591] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2150; }","duration":"101.677141ms","start":"2026-10-13T12:35:43.17346Z","end":"2026-10-13T12:35:43.275137Z","steps":["trace[1149697591] 'range keys from in-memory index tree' (duration: 100.578227ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:35:43.472076Z","caller":"traceutil/trace.go:171","msg":"trace[305007793] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"191.642288ms","start":"2026-10-13T12:35:43.280405Z","end":"2026-10-13T12:35:43.472048Z","steps":["trace[305007793] 'process raft request' (duration: 186.129049ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:35:43.707225Z","caller":"traceutil/trace.go:171","msg":"trace[1420390726] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"129.413855ms","start":"2026-10-13T12:35:43.577782Z","end":"2026-10-13T12:35:43.707196Z","steps":["trace[1420390726] 'process raft request' (duration: 36.049297ms)","trace[1420390726] 'compare' (duration: 93.173246ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T12:35:43.898557Z","caller":"traceutil/trace.go:171","msg":"trace[1029151261] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"186.479272ms","start":"2026-10-13T12:35:43.712053Z","end":"2026-10-13T12:35:43.898532Z","steps":["trace[1029151261] 'process raft request' (duration: 186.121818ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:36:41.709023Z","caller":"traceutil/trace.go:171","msg":"trace[1438744945] transaction","detail":"{read_only:false; response_revision:2513; number_of_response:1; }","duration":"115.456802ms","start":"2026-10-13T12:36:41.593543Z","end":"2026-10-13T12:36:41.709Z","steps":["trace[1438744945] 'process raft request' (duration: 115.299898ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:36:41.709318Z","caller":"traceutil/trace.go:171","msg":"trace[10836405] transaction","detail":"{read_only:false; response_revision:2514; number_of_response:1; }","duration":"115.719409ms","start":"2026-10-13T12:36:41.593584Z","end":"2026-10-13T12:36:41.709304Z","steps":["trace[10836405] 'process raft request' (duration: 115.36742ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:36:41.709392Z","caller":"traceutil/trace.go:171","msg":"trace[848810808] transaction","detail":"{read_only:false; response_revision:2515; number_of_response:1; }","duration":"114.778653ms","start":"2026-10-13T12:36:41.594593Z","end":"2026-10-13T12:36:41.709371Z","steps":["trace[848810808] 'process raft request' (duration: 114.565147ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:36:50.022206Z","caller":"traceutil/trace.go:171","msg":"trace[704449732] transaction","detail":"{read_only:false; response_revision:2610; number_of_response:1; }","duration":"119.32434ms","start":"2026-10-13T12:36:49.902859Z","end":"2026-10-13T12:36:50.022183Z","steps":["trace[704449732] 'process raft request' (duration: 119.201876ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:37:23.405248Z","caller":"traceutil/trace.go:171","msg":"trace[994527481] transaction","detail":"{read_only:false; response_revision:2792; number_of_response:1; }","duration":"174.689395ms","start":"2026-10-13T12:37:23.230536Z","end":"2026-10-13T12:37:23.405226Z","steps":["trace[994527481] 'process raft request' (duration: 174.569943ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:37:23.419711Z","caller":"traceutil/trace.go:171","msg":"trace[804146181] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"188.19803ms","start":"2026-10-13T12:37:23.231489Z","end":"2026-10-13T12:37:23.419687Z","steps":["trace[804146181] 'process raft request' (duration: 187.824611ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:42:02.223108Z","caller":"traceutil/trace.go:171","msg":"trace[1586915285] transaction","detail":"{read_only:false; response_revision:4967; number_of_response:1; }","duration":"123.206012ms","start":"2026-10-13T12:42:02.099877Z","end":"2026-10-13T12:42:02.223083Z","steps":["trace[1586915285] 'process raft request' (duration: 122.841077ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:42:02.493193Z","caller":"traceutil/trace.go:171","msg":"trace[482394173] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"255.997522ms","start":"2026-10-13T12:42:02.23717Z","end":"2026-10-13T12:42:02.493167Z","steps":["trace[482394173] 'process raft request' (duration: 226.235465ms)","trace[482394173] 'compare' (duration: 29.623654ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T12:42:02.547685Z","caller":"traceutil/trace.go:171","msg":"trace[1621148913] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"298.009576ms","start":"2026-10-13T12:42:02.249655Z","end":"2026-10-13T12:42:02.547665Z","steps":["trace[1621148913] 'process raft request' (duration: 297.913275ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:42:09.559565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.085482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3e4d2400-e34c-4664-9538-3f3653bad53a\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-10-13T12:42:09.559644Z","caller":"traceutil/trace.go:171","msg":"trace[234491681] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3e4d2400-e34c-4664-9538-3f3653bad53a; range_end:; response_count:1; response_revision:5129; }","duration":"153.207723ms","start":"2026-10-13T12:42:09.40642Z","end":"2026-10-13T12:42:09.559628Z","steps":["trace[234491681] 'range keys from in-memory index tree' (duration: 152.933299ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:42:09.559892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.186748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T12:42:09.560015Z","caller":"traceutil/trace.go:171","msg":"trace[1018503857] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5129; }","duration":"135.683036ms","start":"2026-10-13T12:42:09.424294Z","end":"2026-10-13T12:42:09.559977Z","steps":["trace[1018503857] 'count revisions from in-memory index tree' (duration: 135.075076ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:42:42.927086Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2898} {"level":"info","ts":"2026-10-13T12:42:43.005688Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2898,"took":"77.272383ms","hash":830387054,"current-db-size-bytes":51355648,"current-db-size":"51 MB","current-db-size-in-use-bytes":27578368,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-13T12:42:43.005759Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":830387054,"revision":2898,"compact-revision":-1} {"level":"info","ts":"2026-10-13T12:46:03.320645Z","caller":"traceutil/trace.go:171","msg":"trace[1210367970] transaction","detail":"{read_only:false; response_revision:6847; number_of_response:1; }","duration":"137.383373ms","start":"2026-10-13T12:46:03.183233Z","end":"2026-10-13T12:46:03.320616Z","steps":["trace[1210367970] 'process raft request' (duration: 137.188967ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:46:03.323457Z","caller":"traceutil/trace.go:171","msg":"trace[234063182] transaction","detail":"{read_only:false; response_revision:6848; number_of_response:1; }","duration":"139.526882ms","start":"2026-10-13T12:46:03.183891Z","end":"2026-10-13T12:46:03.323418Z","steps":["trace[234063182] 'process raft request' (duration: 138.499509ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:47:42.933063Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5379} {"level":"info","ts":"2026-10-13T12:47:43.028649Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5379,"took":"94.115322ms","hash":2059107674,"current-db-size-bytes":51355648,"current-db-size":"51 MB","current-db-size-in-use-bytes":18632704,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-13T12:47:43.028726Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2059107674,"revision":5379,"compact-revision":2898}