{"level":"warn","ts":"2026-10-07T05:37:54.576962Z","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-07T05:37:54.577093Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.218: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.218:2380","--initial-cluster=instance=https://162.253.55.218:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.218:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.218: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-07T05:37:54.577188Z","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-07T05:37:54.577202Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-10-07T05:37:54.577231Z","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-07T05:37:54.579335Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"]} {"level":"info","ts":"2026-10-07T05:37:54.579576Z","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.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.218: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-07T05:37:54.588166Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.110757ms"} {"level":"info","ts":"2026-10-07T05:37:54.600003Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bb7d59f4041c8abe","cluster-id":"5330ca29224af3c4"} {"level":"info","ts":"2026-10-07T05:37:54.600091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=()"} {"level":"info","ts":"2026-10-07T05:37:54.600108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 0"} {"level":"info","ts":"2026-10-07T05:37:54.600116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bb7d59f4041c8abe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-07T05:37:54.600126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 1"} {"level":"info","ts":"2026-10-07T05:37:54.600162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"warn","ts":"2026-10-07T05:37:54.605898Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-07T05:37:54.607273Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-07T05:37:54.609284Z","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-07T05:37:54.611723Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bb7d59f4041c8abe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-07T05:37:54.611979Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bb7d59f4041c8abe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-07T05:37:54.612011Z","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-07T05:37:54.612126Z","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-07T05:37:54.612146Z","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-07T05:37:54.613032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"info","ts":"2026-10-07T05:37:54.613187Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","added-peer-id":"bb7d59f4041c8abe","added-peer-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-10-07T05:37:54.614691Z","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-07T05:37:54.61474Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-10-07T05:37:54.614796Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-10-07T05:37:54.614921Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bb7d59f4041c8abe","initial-advertise-peer-urls":["https://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-07T05:37:54.614955Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-07T05:37:55.600776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe is starting a new election at term 1"} {"level":"info","ts":"2026-10-07T05:37:55.600823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became pre-candidate at term 1"} {"level":"info","ts":"2026-10-07T05:37:55.600846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgPreVoteResp from bb7d59f4041c8abe at term 1"} {"level":"info","ts":"2026-10-07T05:37:55.600858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became candidate at term 2"} {"level":"info","ts":"2026-10-07T05:37:55.600863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgVoteResp from bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-10-07T05:37:55.600871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became leader at term 2"} {"level":"info","ts":"2026-10-07T05:37:55.600878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bb7d59f4041c8abe elected leader bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-10-07T05:37:55.601799Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T05:37:55.602519Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-07T05:37:55.602513Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bb7d59f4041c8abe","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.218:2379]}","request-path":"/0/members/bb7d59f4041c8abe/attributes","cluster-id":"5330ca29224af3c4","publish-timeout":"7s"} {"level":"info","ts":"2026-10-07T05:37:55.602599Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-07T05:37:55.60292Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T05:37:55.603025Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T05:37:55.603081Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-07T05:37:55.603127Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-07T05:37:55.60332Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T05:37:55.605348Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-07T05:37:55.606555Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.218:2379"} {"level":"info","ts":"2026-10-07T05:38:43.246702Z","caller":"traceutil/trace.go:171","msg":"trace[690839951] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"230.720582ms","start":"2026-10-07T05:38:43.015958Z","end":"2026-10-07T05:38:43.246678Z","steps":["trace[690839951] 'process raft request' (duration: 189.417953ms)","trace[690839951] 'compare' (duration: 41.151663ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:38:43.246903Z","caller":"traceutil/trace.go:171","msg":"trace[532353370] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"227.06305ms","start":"2026-10-07T05:38:43.019829Z","end":"2026-10-07T05:38:43.246892Z","steps":["trace[532353370] 'process raft request' (duration: 226.80056ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:38:43.431548Z","caller":"traceutil/trace.go:171","msg":"trace[1055460556] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"298.150484ms","start":"2026-10-07T05:38:43.133358Z","end":"2026-10-07T05:38:43.431509Z","steps":["trace[1055460556] 'process raft request' (duration: 297.395943ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:38:44.003376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.024743ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-07T05:38:44.003687Z","caller":"traceutil/trace.go:171","msg":"trace[145049737] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"438.036956ms","start":"2026-10-07T05:38:43.565591Z","end":"2026-10-07T05:38:44.003628Z","steps":["trace[145049737] 'read index received' (duration: 222.030442ms)","trace[145049737] 'applied index is now lower than readState.Index' (duration: 216.004514ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:38:44.003709Z","caller":"traceutil/trace.go:171","msg":"trace[328466389] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"492.700269ms","start":"2026-10-07T05:38:43.510978Z","end":"2026-10-07T05:38:44.003678Z","steps":["trace[328466389] 'process raft request' (duration: 276.704395ms)","trace[328466389] 'compare' (duration: 214.852656ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T05:38:44.003947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.352968ms","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-07T05:38:44.003983Z","caller":"traceutil/trace.go:171","msg":"trace[1285552000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"438.441932ms","start":"2026-10-07T05:38:43.565531Z","end":"2026-10-07T05:38:44.003973Z","steps":["trace[1285552000] 'agreement among raft nodes before linearized reading' (duration: 438.230743ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:38:44.00402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:38:43.565479Z","time spent":"438.533175ms","remote":"127.0.0.1:46328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-07T05:38:44.004135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:38:43.510956Z","time spent":"493.001281ms","remote":"127.0.0.1:46582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T05:38:44.004343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.876388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T05:38:44.004461Z","caller":"traceutil/trace.go:171","msg":"trace[1058409617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"267.045535ms","start":"2026-10-07T05:38:43.737398Z","end":"2026-10-07T05:38:44.004444Z","steps":["trace[1058409617] 'agreement among raft nodes before linearized reading' (duration: 266.888298ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:39:00.337337Z","caller":"traceutil/trace.go:171","msg":"trace[1370925954] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"223.920945ms","start":"2026-10-07T05:39:00.113396Z","end":"2026-10-07T05:39:00.337317Z","steps":["trace[1370925954] 'read index received' (duration: 223.78761ms)","trace[1370925954] 'applied index is now lower than readState.Index' (duration: 132.625µs)"],"step_count":2} {"level":"warn","ts":"2026-10-07T05:39:00.33754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.104183ms","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-07T05:39:00.337599Z","caller":"traceutil/trace.go:171","msg":"trace[1672084978] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"228.216936ms","start":"2026-10-07T05:39:00.109353Z","end":"2026-10-07T05:39:00.33757Z","steps":["trace[1672084978] 'process raft request' (duration: 227.870941ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:39:00.337598Z","caller":"traceutil/trace.go:171","msg":"trace[1127522630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:768; }","duration":"224.204007ms","start":"2026-10-07T05:39:00.113382Z","end":"2026-10-07T05:39:00.337586Z","steps":["trace[1127522630] 'agreement among raft nodes before linearized reading' (duration: 224.021ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:39:57.626013Z","caller":"traceutil/trace.go:171","msg":"trace[185071253] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"170.652732ms","start":"2026-10-07T05:39:57.455317Z","end":"2026-10-07T05:39:57.62597Z","steps":["trace[185071253] 'process raft request' (duration: 165.037828ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:40:21.346656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.886252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af6593af-cdff-4884-b49f-aedf7ad5caf5\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-07T05:40:21.346754Z","caller":"traceutil/trace.go:171","msg":"trace[1456608926] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-af6593af-cdff-4884-b49f-aedf7ad5caf5; range_end:; response_count:1; response_revision:1856; }","duration":"266.037109ms","start":"2026-10-07T05:40:21.080699Z","end":"2026-10-07T05:40:21.346736Z","steps":["trace[1456608926] 'range keys from in-memory index tree' (duration: 265.527037ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:40:21.749729Z","caller":"traceutil/trace.go:171","msg":"trace[263471873] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"255.233474ms","start":"2026-10-07T05:40:21.494455Z","end":"2026-10-07T05:40:21.749688Z","steps":["trace[263471873] 'process raft request' (duration: 255.070157ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:40:32.761722Z","caller":"traceutil/trace.go:171","msg":"trace[331490861] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"134.077103ms","start":"2026-10-07T05:40:32.627619Z","end":"2026-10-07T05:40:32.761696Z","steps":["trace[331490861] 'process raft request' (duration: 133.824961ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:40:36.029782Z","caller":"traceutil/trace.go:171","msg":"trace[1745770529] linearizableReadLoop","detail":"{readStateIndex:2049; appliedIndex:2048; }","duration":"203.452936ms","start":"2026-10-07T05:40:35.826311Z","end":"2026-10-07T05:40:36.029764Z","steps":["trace[1745770529] 'read index received' (duration: 203.306435ms)","trace[1745770529] 'applied index is now lower than readState.Index' (duration: 145.501µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:40:36.02987Z","caller":"traceutil/trace.go:171","msg":"trace[745363763] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"209.245482ms","start":"2026-10-07T05:40:35.820575Z","end":"2026-10-07T05:40:36.029821Z","steps":["trace[745363763] 'process raft request' (duration: 209.08121ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:40:36.030036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.709139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-07T05:40:36.030124Z","caller":"traceutil/trace.go:171","msg":"trace[1621259874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1972; }","duration":"203.8477ms","start":"2026-10-07T05:40:35.826256Z","end":"2026-10-07T05:40:36.030104Z","steps":["trace[1621259874] 'agreement among raft nodes before linearized reading' (duration: 203.602557ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:41:00.241419Z","caller":"traceutil/trace.go:171","msg":"trace[306072418] linearizableReadLoop","detail":"{readStateIndex:2199; appliedIndex:2198; }","duration":"112.174007ms","start":"2026-10-07T05:41:00.129218Z","end":"2026-10-07T05:41:00.241392Z","steps":["trace[306072418] 'read index received' (duration: 111.940663ms)","trace[306072418] 'applied index is now lower than readState.Index' (duration: 231.944µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:41:00.241606Z","caller":"traceutil/trace.go:171","msg":"trace[1294556310] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"116.00867ms","start":"2026-10-07T05:41:00.125582Z","end":"2026-10-07T05:41:00.24159Z","steps":["trace[1294556310] 'process raft request' (duration: 115.650994ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:41:00.241753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.447602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-07T05:41:00.241833Z","caller":"traceutil/trace.go:171","msg":"trace[848984794] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2117; }","duration":"100.554123ms","start":"2026-10-07T05:41:00.141259Z","end":"2026-10-07T05:41:00.241813Z","steps":["trace[848984794] 'agreement among raft nodes before linearized reading' (duration: 100.38295ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:41:00.242137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.898749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-07T05:41:00.242195Z","caller":"traceutil/trace.go:171","msg":"trace[2050517318] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2117; }","duration":"113.050301ms","start":"2026-10-07T05:41:00.12913Z","end":"2026-10-07T05:41:00.24218Z","steps":["trace[2050517318] 'agreement among raft nodes before linearized reading' (duration: 112.736396ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:41:00.406296Z","caller":"traceutil/trace.go:171","msg":"trace[349307922] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"160.827156ms","start":"2026-10-07T05:41:00.245434Z","end":"2026-10-07T05:41:00.406261Z","steps":["trace[349307922] 'process raft request' (duration: 79.840598ms)","trace[349307922] 'compare' (duration: 80.854576ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:41:00.429107Z","caller":"traceutil/trace.go:171","msg":"trace[2080957313] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"183.042816ms","start":"2026-10-07T05:41:00.245997Z","end":"2026-10-07T05:41:00.42904Z","steps":["trace[2080957313] 'process raft request' (duration: 182.626738ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:41:00.429181Z","caller":"traceutil/trace.go:171","msg":"trace[1156931855] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"182.044838ms","start":"2026-10-07T05:41:00.247111Z","end":"2026-10-07T05:41:00.429156Z","steps":["trace[1156931855] 'process raft request' (duration: 181.754723ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:41:00.429933Z","caller":"traceutil/trace.go:171","msg":"trace[90468105] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"182.684759ms","start":"2026-10-07T05:41:00.247228Z","end":"2026-10-07T05:41:00.429912Z","steps":["trace[90468105] 'process raft request' (duration: 181.741214ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:42:24.636788Z","caller":"traceutil/trace.go:171","msg":"trace[327245679] transaction","detail":"{read_only:false; response_revision:2680; number_of_response:1; }","duration":"109.750873ms","start":"2026-10-07T05:42:24.527008Z","end":"2026-10-07T05:42:24.636759Z","steps":["trace[327245679] 'process raft request' (duration: 109.571678ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:46:47.560214Z","caller":"traceutil/trace.go:171","msg":"trace[1230350237] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4740; }","duration":"135.572735ms","start":"2026-10-07T05:46:47.424614Z","end":"2026-10-07T05:46:47.560187Z","steps":["trace[1230350237] 'process raft request' (duration: 41.194936ms)","trace[1230350237] 'compare' (duration: 94.316537ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:46:47.598803Z","caller":"traceutil/trace.go:171","msg":"trace[1506854067] linearizableReadLoop","detail":"{readStateIndex:4922; appliedIndex:4920; }","duration":"150.603401ms","start":"2026-10-07T05:46:47.448182Z","end":"2026-10-07T05:46:47.598786Z","steps":["trace[1506854067] 'read index received' (duration: 17.635636ms)","trace[1506854067] 'applied index is now lower than readState.Index' (duration: 132.967275ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T05:46:47.59896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.757947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-10-07T05:46:47.598982Z","caller":"traceutil/trace.go:171","msg":"trace[217371626] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4741; }","duration":"150.825631ms","start":"2026-10-07T05:46:47.44815Z","end":"2026-10-07T05:46:47.598975Z","steps":["trace[217371626] 'agreement among raft nodes before linearized reading' (duration: 150.718727ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:46:47.598966Z","caller":"traceutil/trace.go:171","msg":"trace[2085324802] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"167.625606ms","start":"2026-10-07T05:46:47.431312Z","end":"2026-10-07T05:46:47.598937Z","steps":["trace[2085324802] 'process raft request' (duration: 167.131247ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:46:47.635892Z","caller":"traceutil/trace.go:171","msg":"trace[1032598525] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"167.348305ms","start":"2026-10-07T05:46:47.468523Z","end":"2026-10-07T05:46:47.635871Z","steps":["trace[1032598525] 'process raft request' (duration: 167.074834ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:46:47.754581Z","caller":"traceutil/trace.go:171","msg":"trace[124822962] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"108.799911ms","start":"2026-10-07T05:46:47.645758Z","end":"2026-10-07T05:46:47.754557Z","steps":["trace[124822962] 'process raft request' (duration: 108.739529ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:46:47.754595Z","caller":"traceutil/trace.go:171","msg":"trace[1618791697] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"109.02264ms","start":"2026-10-07T05:46:47.645544Z","end":"2026-10-07T05:46:47.754567Z","steps":["trace[1618791697] 'process raft request' (duration: 108.844224ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:46:53.702434Z","caller":"traceutil/trace.go:171","msg":"trace[1795051397] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"372.531792ms","start":"2026-10-07T05:46:53.329845Z","end":"2026-10-07T05:46:53.702377Z","steps":["trace[1795051397] 'process raft request' (duration: 372.391347ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:46:53.702785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:46:53.329833Z","time spent":"372.670807ms","remote":"127.0.0.1:46246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3748,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T05:46:53.733851Z","caller":"traceutil/trace.go:171","msg":"trace[862614053] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"403.941599ms","start":"2026-10-07T05:46:53.329862Z","end":"2026-10-07T05:46:53.733803Z","steps":["trace[862614053] 'process raft request' (duration: 403.676099ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:46:53.733912Z","caller":"traceutil/trace.go:171","msg":"trace[369353861] transaction","detail":"{read_only:false; response_revision:4850; number_of_response:1; }","duration":"248.30782ms","start":"2026-10-07T05:46:53.485581Z","end":"2026-10-07T05:46:53.733888Z","steps":["trace[369353861] 'process raft request' (duration: 248.127843ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:46:53.734011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:46:53.329837Z","time spent":"404.094035ms","remote":"127.0.0.1:46138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":880,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T05:46:53.734268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.42982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-07T05:46:53.734323Z","caller":"traceutil/trace.go:171","msg":"trace[334375096] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:4852; }","duration":"327.541745ms","start":"2026-10-07T05:46:53.406769Z","end":"2026-10-07T05:46:53.734311Z","steps":["trace[334375096] 'agreement among raft nodes before linearized reading' (duration: 327.436021ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:46:53.734359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:46:53.406751Z","time spent":"327.598517ms","remote":"127.0.0.1:46348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":4,"response size":30,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-10-07T05:46:53.734058Z","caller":"traceutil/trace.go:171","msg":"trace[1556182895] linearizableReadLoop","detail":"{readStateIndex:5031; appliedIndex:5029; }","duration":"327.208482ms","start":"2026-10-07T05:46:53.406822Z","end":"2026-10-07T05:46:53.73403Z","steps":["trace[1556182895] 'read index received' (duration: 295.41053ms)","trace[1556182895] 'applied index is now lower than readState.Index' (duration: 31.796772ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T05:46:53.734794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.437786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T05:46:53.734833Z","caller":"traceutil/trace.go:171","msg":"trace[1414045075] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:4852; }","duration":"246.513449ms","start":"2026-10-07T05:46:53.488307Z","end":"2026-10-07T05:46:53.734821Z","steps":["trace[1414045075] 'agreement among raft nodes before linearized reading' (duration: 246.454017ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:46:53.735005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.575476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-68fce52f-a187-4252-8166-50af888b2bdf\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-10-07T05:46:53.735039Z","caller":"traceutil/trace.go:171","msg":"trace[892066194] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-68fce52f-a187-4252-8166-50af888b2bdf; range_end:; response_count:1; response_revision:4852; }","duration":"221.656199ms","start":"2026-10-07T05:46:53.513372Z","end":"2026-10-07T05:46:53.735028Z","steps":["trace[892066194] 'agreement among raft nodes before linearized reading' (duration: 221.538645ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:47:06.502629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.639416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-07T05:47:06.50273Z","caller":"traceutil/trace.go:171","msg":"trace[1887569306] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5027; }","duration":"302.783951ms","start":"2026-10-07T05:47:06.19992Z","end":"2026-10-07T05:47:06.502704Z","steps":["trace[1887569306] 'range keys from in-memory index tree' (duration: 302.423497ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:47:06.502776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:47:06.199894Z","time spent":"302.871604ms","remote":"127.0.0.1:46328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-07T05:47:06.502777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.435498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-07T05:47:06.502846Z","caller":"traceutil/trace.go:171","msg":"trace[1244867326] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5027; }","duration":"201.531542ms","start":"2026-10-07T05:47:06.301294Z","end":"2026-10-07T05:47:06.502825Z","steps":["trace[1244867326] 'range keys from in-memory index tree' (duration: 201.25951ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:47:06.502995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.893465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-07T05:47:06.503018Z","caller":"traceutil/trace.go:171","msg":"trace[1950919487] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5027; }","duration":"215.937507ms","start":"2026-10-07T05:47:06.287073Z","end":"2026-10-07T05:47:06.50301Z","steps":["trace[1950919487] 'range keys from in-memory index tree' (duration: 215.811391ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:47:06.636853Z","caller":"traceutil/trace.go:171","msg":"trace[1167314560] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"129.982816ms","start":"2026-10-07T05:47:06.50684Z","end":"2026-10-07T05:47:06.636823Z","steps":["trace[1167314560] 'process raft request' (duration: 129.8107ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:47:06.702148Z","caller":"traceutil/trace.go:171","msg":"trace[1284214663] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"194.87463ms","start":"2026-10-07T05:47:06.507246Z","end":"2026-10-07T05:47:06.702121Z","steps":["trace[1284214663] 'process raft request' (duration: 194.794167ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:47:06.702207Z","caller":"traceutil/trace.go:171","msg":"trace[1276143722] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"194.966553ms","start":"2026-10-07T05:47:06.507213Z","end":"2026-10-07T05:47:06.70218Z","steps":["trace[1276143722] 'process raft request' (duration: 194.710944ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:47:55.670878Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2849} {"level":"info","ts":"2026-10-07T05:47:55.845225Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2849,"took":"172.968807ms","hash":3680626837,"current-db-size-bytes":52326400,"current-db-size":"52 MB","current-db-size-in-use-bytes":28463104,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-07T05:47:55.845319Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3680626837,"revision":2849,"compact-revision":-1} {"level":"warn","ts":"2026-10-07T05:50:56.035058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.46247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-10-07T05:50:56.035178Z","caller":"traceutil/trace.go:171","msg":"trace[108949312] 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:6684; }","duration":"110.593753ms","start":"2026-10-07T05:50:55.924557Z","end":"2026-10-07T05:50:56.035151Z","steps":["trace[108949312] 'range keys from in-memory index tree' (duration: 110.275346ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:52:55.677139Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5455} {"level":"info","ts":"2026-10-07T05:52:55.825716Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5455,"took":"146.919527ms","hash":600671279,"current-db-size-bytes":52326400,"current-db-size":"52 MB","current-db-size-in-use-bytes":18624512,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-07T05:52:55.825986Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":600671279,"revision":5455,"compact-revision":2849}