{"level":"warn","ts":"2026-09-18T01:24:48.171244Z","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-18T01:24:48.171347Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.79: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.79:2380","--initial-cluster=instance=https://162.253.55.79:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.79:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.79: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-18T01:24:48.171423Z","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-18T01:24:48.171432Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-09-18T01:24:48.171455Z","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-18T01:24:48.172218Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"]} {"level":"info","ts":"2026-09-18T01:24:48.172319Z","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.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.79: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-18T01:24:48.176826Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.256085ms"} {"level":"info","ts":"2026-09-18T01:24:48.183881Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"401ca643156fc5da","cluster-id":"e9f568c3681bb0d0"} {"level":"info","ts":"2026-09-18T01:24:48.183951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T01:24:48.184001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 0"} {"level":"info","ts":"2026-09-18T01:24:48.18401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 401ca643156fc5da [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T01:24:48.184023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 1"} {"level":"info","ts":"2026-09-18T01:24:48.184058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"warn","ts":"2026-09-18T01:24:48.193644Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T01:24:48.196341Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T01:24:48.19747Z","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-18T01:24:48.199484Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"401ca643156fc5da","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T01:24:48.200748Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"401ca643156fc5da","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T01:24:48.201043Z","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-18T01:24:48.201172Z","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-18T01:24:48.201186Z","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-18T01:24:48.201329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"info","ts":"2026-09-18T01:24:48.202092Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","added-peer-id":"401ca643156fc5da","added-peer-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-09-18T01:24:48.203269Z","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-18T01:24:48.203459Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"401ca643156fc5da","initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T01:24:48.203481Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T01:24:48.203538Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-09-18T01:24:48.203551Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-09-18T01:24:48.985213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T01:24:48.985309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T01:24:48.985338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgPreVoteResp from 401ca643156fc5da at term 1"} {"level":"info","ts":"2026-09-18T01:24:48.985387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became candidate at term 2"} {"level":"info","ts":"2026-09-18T01:24:48.985405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgVoteResp from 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-09-18T01:24:48.985425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became leader at term 2"} {"level":"info","ts":"2026-09-18T01:24:48.985439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 401ca643156fc5da elected leader 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-09-18T01:24:48.987416Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"401ca643156fc5da","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.79:2379]}","request-path":"/0/members/401ca643156fc5da/attributes","cluster-id":"e9f568c3681bb0d0","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T01:24:48.987425Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T01:24:48.987457Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:24:48.987641Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T01:24:48.988395Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T01:24:48.988426Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T01:24:48.988777Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:24:48.988951Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:24:48.989016Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:24:48.989963Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.79:2379"} {"level":"info","ts":"2026-09-18T01:24:48.993895Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T01:24:59.222148Z","caller":"traceutil/trace.go:171","msg":"trace[473165206] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:394; }","duration":"112.986373ms","start":"2026-09-18T01:24:59.10906Z","end":"2026-09-18T01:24:59.222046Z","steps":["trace[473165206] 'read index received' (duration: 106.116797ms)","trace[473165206] 'applied index is now lower than readState.Index' (duration: 6.867126ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:24:59.224146Z","caller":"traceutil/trace.go:171","msg":"trace[79016857] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"188.387126ms","start":"2026-09-18T01:24:59.035718Z","end":"2026-09-18T01:24:59.224105Z","steps":["trace[79016857] 'process raft request' (duration: 179.505371ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:24:59.224571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.464158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-09-18T01:24:59.224637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.880091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-18T01:24:59.224687Z","caller":"traceutil/trace.go:171","msg":"trace[1066865473] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:382; }","duration":"115.658581ms","start":"2026-09-18T01:24:59.109001Z","end":"2026-09-18T01:24:59.224659Z","steps":["trace[1066865473] 'agreement among raft nodes before linearized reading' (duration: 115.357896ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:24:59.224705Z","caller":"traceutil/trace.go:171","msg":"trace[885130713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:382; }","duration":"103.047533ms","start":"2026-09-18T01:24:59.121644Z","end":"2026-09-18T01:24:59.224692Z","steps":["trace[885130713] 'agreement among raft nodes before linearized reading' (duration: 102.864421ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:25:05.055032Z","caller":"traceutil/trace.go:171","msg":"trace[1594143307] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"203.297351ms","start":"2026-09-18T01:25:04.851712Z","end":"2026-09-18T01:25:05.055009Z","steps":["trace[1594143307] 'process raft request' (duration: 203.108509ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:25:05.371012Z","caller":"traceutil/trace.go:171","msg":"trace[1225558384] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:421; }","duration":"119.493875ms","start":"2026-09-18T01:25:05.251483Z","end":"2026-09-18T01:25:05.370977Z","steps":["trace[1225558384] 'read index received' (duration: 119.294062ms)","trace[1225558384] 'applied index is now lower than readState.Index' (duration: 197.943µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:25:05.371393Z","caller":"traceutil/trace.go:171","msg":"trace[328741775] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"308.911715ms","start":"2026-09-18T01:25:05.062272Z","end":"2026-09-18T01:25:05.371184Z","steps":["trace[328741775] 'process raft request' (duration: 308.451059ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:25:05.371408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.9036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-18T01:25:05.371466Z","caller":"traceutil/trace.go:171","msg":"trace[573810244] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:407; }","duration":"120.005132ms","start":"2026-09-18T01:25:05.251442Z","end":"2026-09-18T01:25:05.371447Z","steps":["trace[573810244] 'agreement among raft nodes before linearized reading' (duration: 119.898121ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:25:05.372081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.534333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-18T01:25:05.372175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:25:05.062251Z","time spent":"309.192189ms","remote":"127.0.0.1:55570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4115,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:25:05.372228Z","caller":"traceutil/trace.go:171","msg":"trace[1312549962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:407; }","duration":"118.691345ms","start":"2026-09-18T01:25:05.253475Z","end":"2026-09-18T01:25:05.372166Z","steps":["trace[1312549962] 'agreement among raft nodes before linearized reading' (duration: 118.482322ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:25:06.598576Z","caller":"traceutil/trace.go:171","msg":"trace[390149836] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"167.316886ms","start":"2026-09-18T01:25:06.431233Z","end":"2026-09-18T01:25:06.59855Z","steps":["trace[390149836] 'process raft request' (duration: 167.091543ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:26:09.103339Z","caller":"traceutil/trace.go:171","msg":"trace[821233941] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"130.110628ms","start":"2026-09-18T01:26:08.973203Z","end":"2026-09-18T01:26:09.103314Z","steps":["trace[821233941] 'process raft request' (duration: 130.015035ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:26:09.103509Z","caller":"traceutil/trace.go:171","msg":"trace[318652742] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"138.45501ms","start":"2026-09-18T01:26:08.965026Z","end":"2026-09-18T01:26:09.103481Z","steps":["trace[318652742] 'process raft request' (duration: 130.475624ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:26:11.697383Z","caller":"traceutil/trace.go:171","msg":"trace[816083402] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"123.84563ms","start":"2026-09-18T01:26:11.573502Z","end":"2026-09-18T01:26:11.697347Z","steps":["trace[816083402] 'process raft request' (duration: 84.59636ms)","trace[816083402] 'compare' (duration: 38.463664ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:26:15.876966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.715818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:26:15.877156Z","caller":"traceutil/trace.go:171","msg":"trace[1760937985] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:784; }","duration":"121.913754ms","start":"2026-09-18T01:26:15.755148Z","end":"2026-09-18T01:26:15.877061Z","steps":["trace[1760937985] 'range keys from in-memory index tree' (duration: 121.603465ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:26:15.930257Z","caller":"traceutil/trace.go:171","msg":"trace[716289984] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"104.865183ms","start":"2026-09-18T01:26:15.824975Z","end":"2026-09-18T01:26:15.92984Z","steps":["trace[716289984] 'process raft request' (duration: 104.654626ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:26:16.25358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.998459ms","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-09-18T01:26:16.253719Z","caller":"traceutil/trace.go:171","msg":"trace[545062832] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:788; }","duration":"137.191965ms","start":"2026-09-18T01:26:16.116501Z","end":"2026-09-18T01:26:16.253693Z","steps":["trace[545062832] 'range keys from in-memory index tree' (duration: 136.816733ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:26:34.373944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.845526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-09-18T01:26:34.374031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.047398ms","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-18T01:26:34.374077Z","caller":"traceutil/trace.go:171","msg":"trace[137811767] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:905; }","duration":"342.034411ms","start":"2026-09-18T01:26:34.032016Z","end":"2026-09-18T01:26:34.37405Z","steps":["trace[137811767] 'range keys from in-memory index tree' (duration: 341.63557ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:26:34.374121Z","caller":"traceutil/trace.go:171","msg":"trace[788787074] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:905; }","duration":"196.152551ms","start":"2026-09-18T01:26:34.177941Z","end":"2026-09-18T01:26:34.374094Z","steps":["trace[788787074] 'range keys from in-memory index tree' (duration: 195.845993ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:26:34.374126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:26:34.031984Z","time spent":"342.131763ms","remote":"127.0.0.1:55658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-18T01:26:34.374424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.328315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-18T01:26:34.374499Z","caller":"traceutil/trace.go:171","msg":"trace[654521110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:905; }","duration":"324.469378ms","start":"2026-09-18T01:26:34.050012Z","end":"2026-09-18T01:26:34.374482Z","steps":["trace[654521110] 'range keys from in-memory index tree' (duration: 324.143269ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:26:34.374546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:26:34.049982Z","time spent":"324.550941ms","remote":"127.0.0.1:55658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-18T01:26:49.397482Z","caller":"traceutil/trace.go:171","msg":"trace[1508995507] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"139.80542ms","start":"2026-09-18T01:26:49.257654Z","end":"2026-09-18T01:26:49.39746Z","steps":["trace[1508995507] 'process raft request' (duration: 97.014575ms)","trace[1508995507] 'compare' (duration: 42.692302ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:26:49.405012Z","caller":"traceutil/trace.go:171","msg":"trace[831047137] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"140.20231ms","start":"2026-09-18T01:26:49.264779Z","end":"2026-09-18T01:26:49.404981Z","steps":["trace[831047137] 'process raft request' (duration: 139.556533ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:26:49.530557Z","caller":"traceutil/trace.go:171","msg":"trace[400823499] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"114.907851ms","start":"2026-09-18T01:26:49.415618Z","end":"2026-09-18T01:26:49.530525Z","steps":["trace[400823499] 'process raft request' (duration: 107.847335ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:27:06.115606Z","caller":"traceutil/trace.go:171","msg":"trace[1826526597] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"187.684812ms","start":"2026-09-18T01:27:05.92785Z","end":"2026-09-18T01:27:06.115535Z","steps":["trace[1826526597] 'process raft request' (duration: 132.385732ms)","trace[1826526597] 'compare' (duration: 54.83416ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:27:57.836572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.541685ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-18T01:27:57.836728Z","caller":"traceutil/trace.go:171","msg":"trace[2100401866] linearizableReadLoop","detail":"{readStateIndex:2092; appliedIndex:2091; }","duration":"378.215286ms","start":"2026-09-18T01:27:57.458487Z","end":"2026-09-18T01:27:57.836702Z","steps":["trace[2100401866] 'read index received' (duration: 74.460207ms)","trace[2100401866] 'applied index is now lower than readState.Index' (duration: 303.753009ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:27:57.837022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.302983ms","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-18T01:27:57.837069Z","caller":"traceutil/trace.go:171","msg":"trace[1651957706] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2008; }","duration":"134.410285ms","start":"2026-09-18T01:27:57.702645Z","end":"2026-09-18T01:27:57.837055Z","steps":["trace[1651957706] 'agreement among raft nodes before linearized reading' (duration: 134.226242ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:27:57.837495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.01459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-12a69038-70bf-439c-9356-d98b5129f4aa\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-18T01:27:57.837537Z","caller":"traceutil/trace.go:171","msg":"trace[162978150] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-12a69038-70bf-439c-9356-d98b5129f4aa; range_end:; response_count:1; response_revision:2008; }","duration":"379.105202ms","start":"2026-09-18T01:27:57.458422Z","end":"2026-09-18T01:27:57.837528Z","steps":["trace[162978150] 'agreement among raft nodes before linearized reading' (duration: 378.391879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:27:57.837568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:27:57.458354Z","time spent":"379.204024ms","remote":"127.0.0.1:55570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-12a69038-70bf-439c-9356-d98b5129f4aa\" "} {"level":"warn","ts":"2026-09-18T01:27:58.137019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.822842ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T01:27:58.137546Z","caller":"traceutil/trace.go:171","msg":"trace[1315721286] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"291.861011ms","start":"2026-09-18T01:27:57.845605Z","end":"2026-09-18T01:27:58.137466Z","steps":["trace[1315721286] 'process raft request' (duration: 166.466768ms)","trace[1315721286] 'compare' (duration: 124.453716ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:27:58.435851Z","caller":"traceutil/trace.go:171","msg":"trace[774504289] linearizableReadLoop","detail":"{readStateIndex:2096; appliedIndex:2095; }","duration":"191.676065ms","start":"2026-09-18T01:27:58.244145Z","end":"2026-09-18T01:27:58.435821Z","steps":["trace[774504289] 'read index received' (duration: 166.017072ms)","trace[774504289] 'applied index is now lower than readState.Index' (duration: 25.658143ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:27:58.435996Z","caller":"traceutil/trace.go:171","msg":"trace[2021891688] transaction","detail":"{read_only:false; response_revision:2012; number_of_response:1; }","duration":"198.847748ms","start":"2026-09-18T01:27:58.237129Z","end":"2026-09-18T01:27:58.435976Z","steps":["trace[2021891688] 'process raft request' (duration: 173.017771ms)","trace[2021891688] 'compare' (duration: 25.524881ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:27:58.436197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.010402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:27:58.436389Z","caller":"traceutil/trace.go:171","msg":"trace[254748713] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2012; }","duration":"192.134874ms","start":"2026-09-18T01:27:58.244113Z","end":"2026-09-18T01:27:58.436248Z","steps":["trace[254748713] 'agreement among raft nodes before linearized reading' (duration: 191.965261ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:27:58.438211Z","caller":"traceutil/trace.go:171","msg":"trace[41917418] transaction","detail":"{read_only:false; response_revision:2013; number_of_response:1; }","duration":"127.310797ms","start":"2026-09-18T01:27:58.310881Z","end":"2026-09-18T01:27:58.438192Z","steps":["trace[41917418] 'process raft request' (duration: 127.167155ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:27:58.438643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.55022ms","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-18T01:27:58.438693Z","caller":"traceutil/trace.go:171","msg":"trace[1303502294] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2014; }","duration":"186.639143ms","start":"2026-09-18T01:27:58.25204Z","end":"2026-09-18T01:27:58.43868Z","steps":["trace[1303502294] 'agreement among raft nodes before linearized reading' (duration: 186.137003ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:28:32.755491Z","caller":"traceutil/trace.go:171","msg":"trace[1917119368] transaction","detail":"{read_only:false; response_revision:2249; number_of_response:1; }","duration":"214.145129ms","start":"2026-09-18T01:28:32.541304Z","end":"2026-09-18T01:28:32.755449Z","steps":["trace[1917119368] 'process raft request' (duration: 126.256577ms)","trace[1917119368] 'compare' (duration: 87.712298ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:28:32.768997Z","caller":"traceutil/trace.go:171","msg":"trace[1876258955] linearizableReadLoop","detail":"{readStateIndex:2342; appliedIndex:2340; }","duration":"127.229143ms","start":"2026-09-18T01:28:32.64175Z","end":"2026-09-18T01:28:32.768979Z","steps":["trace[1876258955] 'read index received' (duration: 25.75986ms)","trace[1876258955] 'applied index is now lower than readState.Index' (duration: 101.468243ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:28:32.769108Z","caller":"traceutil/trace.go:171","msg":"trace[2032656136] transaction","detail":"{read_only:false; response_revision:2250; number_of_response:1; }","duration":"197.313421ms","start":"2026-09-18T01:28:32.571782Z","end":"2026-09-18T01:28:32.769095Z","steps":["trace[2032656136] 'process raft request' (duration: 197.086067ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:28:32.769428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.670991ms","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-18T01:28:32.769493Z","caller":"traceutil/trace.go:171","msg":"trace[1314901730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2250; }","duration":"127.781983ms","start":"2026-09-18T01:28:32.6417Z","end":"2026-09-18T01:28:32.769482Z","steps":["trace[1314901730] 'agreement among raft nodes before linearized reading' (duration: 127.629821ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:28:33.061844Z","caller":"traceutil/trace.go:171","msg":"trace[1437029884] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"154.198253ms","start":"2026-09-18T01:28:32.907619Z","end":"2026-09-18T01:28:33.061817Z","steps":["trace[1437029884] 'process raft request' (duration: 154.003049ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:28:33.31186Z","caller":"traceutil/trace.go:171","msg":"trace[1685957620] transaction","detail":"{read_only:false; response_revision:2253; number_of_response:1; }","duration":"392.000717ms","start":"2026-09-18T01:28:32.919792Z","end":"2026-09-18T01:28:33.311793Z","steps":["trace[1685957620] 'process raft request' (duration: 391.720413ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:28:33.312151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:28:32.919764Z","time spent":"392.241932ms","remote":"127.0.0.1:55658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:28:33.312434Z","caller":"traceutil/trace.go:171","msg":"trace[90548296] transaction","detail":"{read_only:false; response_revision:2254; number_of_response:1; }","duration":"386.472774ms","start":"2026-09-18T01:28:32.925508Z","end":"2026-09-18T01:28:33.311981Z","steps":["trace[90548296] 'process raft request' (duration: 386.187409ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:28:33.312619Z","caller":"traceutil/trace.go:171","msg":"trace[753370865] linearizableReadLoop","detail":"{readStateIndex:2346; appliedIndex:2343; }","duration":"312.031981ms","start":"2026-09-18T01:28:33.000539Z","end":"2026-09-18T01:28:33.312571Z","steps":["trace[753370865] 'read index received' (duration: 61.181664ms)","trace[753370865] 'applied index is now lower than readState.Index' (duration: 250.843697ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:28:33.312673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:28:32.925481Z","time spent":"387.095904ms","remote":"127.0.0.1:55658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T01:28:33.312841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.266706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-18T01:28:33.312862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.634181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T01:28:33.312888Z","caller":"traceutil/trace.go:171","msg":"trace[1822728311] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2254; }","duration":"312.47954ms","start":"2026-09-18T01:28:33.000394Z","end":"2026-09-18T01:28:33.312873Z","steps":["trace[1822728311] 'agreement among raft nodes before linearized reading' (duration: 312.356486ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:28:33.31291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.287241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-18T01:28:33.312936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:28:33.000359Z","time spent":"312.566271ms","remote":"127.0.0.1:55520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-09-18T01:28:33.312975Z","caller":"traceutil/trace.go:171","msg":"trace[1930736443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2254; }","duration":"100.375562ms","start":"2026-09-18T01:28:33.212584Z","end":"2026-09-18T01:28:33.31296Z","steps":["trace[1930736443] 'agreement among raft nodes before linearized reading' (duration: 100.197709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:28:33.313143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.048343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T01:28:33.313238Z","caller":"traceutil/trace.go:171","msg":"trace[347678497] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2254; }","duration":"196.164525ms","start":"2026-09-18T01:28:33.11706Z","end":"2026-09-18T01:28:33.313224Z","steps":["trace[347678497] 'agreement among raft nodes before linearized reading' (duration: 196.037173ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:28:33.312925Z","caller":"traceutil/trace.go:171","msg":"trace[732938169] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2254; }","duration":"204.749033ms","start":"2026-09-18T01:28:33.10816Z","end":"2026-09-18T01:28:33.312909Z","steps":["trace[732938169] 'agreement among raft nodes before linearized reading' (duration: 204.61427ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:28:33.31343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.002755ms","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-18T01:28:33.313502Z","caller":"traceutil/trace.go:171","msg":"trace[1599973030] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2254; }","duration":"107.112027ms","start":"2026-09-18T01:28:33.206376Z","end":"2026-09-18T01:28:33.313488Z","steps":["trace[1599973030] 'agreement among raft nodes before linearized reading' (duration: 106.570558ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:28:33.646214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.84138ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T01:28:33.646526Z","caller":"traceutil/trace.go:171","msg":"trace[1958010257] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"326.966046ms","start":"2026-09-18T01:28:33.319526Z","end":"2026-09-18T01:28:33.646492Z","steps":["trace[1958010257] 'process raft request' (duration: 326.903305ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:28:33.646589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:28:33.319513Z","time spent":"327.044308ms","remote":"127.0.0.1:55658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:28:33.646768Z","caller":"traceutil/trace.go:171","msg":"trace[306850294] transaction","detail":"{read_only:false; response_revision:2256; number_of_response:1; }","duration":"328.91149ms","start":"2026-09-18T01:28:33.317827Z","end":"2026-09-18T01:28:33.646739Z","steps":["trace[306850294] 'process raft request' (duration: 139.446258ms)","trace[306850294] 'compare' (duration: 188.602606ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:28:33.646842Z","caller":"traceutil/trace.go:171","msg":"trace[1364813898] transaction","detail":"{read_only:false; response_revision:2257; number_of_response:1; }","duration":"328.476312ms","start":"2026-09-18T01:28:33.318353Z","end":"2026-09-18T01:28:33.646829Z","steps":["trace[1364813898] 'process raft request' (duration: 327.962904ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:28:33.646905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:28:33.318342Z","time spent":"328.528233ms","remote":"127.0.0.1:55658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T01:28:33.646927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:28:33.317805Z","time spent":"329.020291ms","remote":"127.0.0.1:55658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:29:49.8793Z","caller":"traceutil/trace.go:171","msg":"trace[101708081] transaction","detail":"{read_only:false; response_revision:2764; number_of_response:1; }","duration":"101.706317ms","start":"2026-09-18T01:29:49.777557Z","end":"2026-09-18T01:29:49.879263Z","steps":["trace[101708081] 'process raft request' (duration: 101.228707ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:30:28.090342Z","caller":"traceutil/trace.go:171","msg":"trace[2049520211] transaction","detail":"{read_only:false; response_revision:2972; number_of_response:1; }","duration":"267.74448ms","start":"2026-09-18T01:30:27.822553Z","end":"2026-09-18T01:30:28.090298Z","steps":["trace[2049520211] 'process raft request' (duration: 244.143335ms)","trace[2049520211] 'compare' (duration: 23.366686ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:34:49.035259Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2757} {"level":"info","ts":"2026-09-18T01:34:49.101246Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2757,"took":"64.809129ms","hash":2658638533,"current-db-size-bytes":41467904,"current-db-size":"42 MB","current-db-size-in-use-bytes":16654336,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-09-18T01:34:49.101301Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2658638533,"revision":2757,"compact-revision":-1} {"level":"warn","ts":"2026-09-18T01:35:20.287884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.642191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T01:35:20.287994Z","caller":"traceutil/trace.go:171","msg":"trace[193694039] linearizableReadLoop","detail":"{readStateIndex:5414; appliedIndex:5413; }","duration":"123.134383ms","start":"2026-09-18T01:35:20.164842Z","end":"2026-09-18T01:35:20.287976Z","steps":["trace[193694039] 'read index received' (duration: 5.255156ms)","trace[193694039] 'applied index is now lower than readState.Index' (duration: 117.877166ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:35:20.288088Z","caller":"traceutil/trace.go:171","msg":"trace[954745874] transaction","detail":"{read_only:false; response_revision:5208; number_of_response:1; }","duration":"247.810065ms","start":"2026-09-18T01:35:20.040263Z","end":"2026-09-18T01:35:20.288073Z","steps":["trace[954745874] 'process raft request' (duration: 129.908539ms)","trace[954745874] 'compare' (duration: 117.393456ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T01:35:20.288317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.497558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-18T01:35:20.288393Z","caller":"traceutil/trace.go:171","msg":"trace[2001522347] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5208; }","duration":"116.63816ms","start":"2026-09-18T01:35:20.171738Z","end":"2026-09-18T01:35:20.288376Z","steps":["trace[2001522347] 'agreement among raft nodes before linearized reading' (duration: 116.397226ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:20.288606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.755615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-18T01:35:20.288651Z","caller":"traceutil/trace.go:171","msg":"trace[1579594717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5208; }","duration":"123.841606ms","start":"2026-09-18T01:35:20.164798Z","end":"2026-09-18T01:35:20.288639Z","steps":["trace[1579594717] 'agreement among raft nodes before linearized reading' (duration: 123.678312ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:35:20.463063Z","caller":"traceutil/trace.go:171","msg":"trace[1971134482] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"100.537517ms","start":"2026-09-18T01:35:20.36249Z","end":"2026-09-18T01:35:20.463028Z","steps":["trace[1971134482] 'process raft request' (duration: 54.669002ms)","trace[1971134482] 'compare' (duration: 45.722602ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:35:20.466823Z","caller":"traceutil/trace.go:171","msg":"trace[1070325794] linearizableReadLoop","detail":"{readStateIndex:5422; appliedIndex:5419; }","duration":"101.922134ms","start":"2026-09-18T01:35:20.364874Z","end":"2026-09-18T01:35:20.466796Z","steps":["trace[1070325794] 'read index received' (duration: 52.391176ms)","trace[1070325794] 'applied index is now lower than readState.Index' (duration: 49.529458ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:35:20.467084Z","caller":"traceutil/trace.go:171","msg":"trace[235434012] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"102.527568ms","start":"2026-09-18T01:35:20.364534Z","end":"2026-09-18T01:35:20.467061Z","steps":["trace[235434012] 'process raft request' (duration: 101.944476ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:35:20.467244Z","caller":"traceutil/trace.go:171","msg":"trace[1465774006] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"102.567027ms","start":"2026-09-18T01:35:20.364634Z","end":"2026-09-18T01:35:20.467202Z","steps":["trace[1465774006] 'process raft request' (duration: 101.967446ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:35:20.468041Z","caller":"traceutil/trace.go:171","msg":"trace[2017091320] transaction","detail":"{read_only:false; response_revision:5217; number_of_response:1; }","duration":"102.541427ms","start":"2026-09-18T01:35:20.365479Z","end":"2026-09-18T01:35:20.46802Z","steps":["trace[2017091320] 'process raft request' (duration: 101.167349ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:20.468094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.073187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-6a104d02-f997-4ab3-b873-d96320757ae0\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-09-18T01:35:20.468151Z","caller":"traceutil/trace.go:171","msg":"trace[376154631] range","detail":"{range_begin:/registry/persistentvolumes/pvc-6a104d02-f997-4ab3-b873-d96320757ae0; range_end:; response_count:1; response_revision:5218; }","duration":"103.301162ms","start":"2026-09-18T01:35:20.364833Z","end":"2026-09-18T01:35:20.468134Z","steps":["trace[376154631] 'agreement among raft nodes before linearized reading' (duration: 102.420935ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:35:23.514682Z","caller":"traceutil/trace.go:171","msg":"trace[1004923247] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"120.085576ms","start":"2026-09-18T01:35:23.394544Z","end":"2026-09-18T01:35:23.51463Z","steps":["trace[1004923247] 'process raft request' (duration: 119.459354ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:34.594112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.252952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13289"} {"level":"info","ts":"2026-09-18T01:35:34.594222Z","caller":"traceutil/trace.go:171","msg":"trace[1213162816] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5451; }","duration":"125.403615ms","start":"2026-09-18T01:35:34.46879Z","end":"2026-09-18T01:35:34.594194Z","steps":["trace[1213162816] 'range keys from in-memory index tree' (duration: 125.077418ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:34.594668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.656058ms","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-18T01:35:34.594707Z","caller":"traceutil/trace.go:171","msg":"trace[1825515971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5451; }","duration":"168.722569ms","start":"2026-09-18T01:35:34.425974Z","end":"2026-09-18T01:35:34.594696Z","steps":["trace[1825515971] 'range keys from in-memory index tree' (duration: 168.553056ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:34.594897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.439753ms","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":"info","ts":"2026-09-18T01:35:34.594933Z","caller":"traceutil/trace.go:171","msg":"trace[330235144] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5451; }","duration":"163.530635ms","start":"2026-09-18T01:35:34.431391Z","end":"2026-09-18T01:35:34.594922Z","steps":["trace[330235144] 'range keys from in-memory index tree' (duration: 163.312871ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:34.596612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.556608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-09-18T01:35:34.59686Z","caller":"traceutil/trace.go:171","msg":"trace[1466329321] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:5451; }","duration":"130.805103ms","start":"2026-09-18T01:35:34.465955Z","end":"2026-09-18T01:35:34.59676Z","steps":["trace[1466329321] 'range keys from in-memory index tree' (duration: 128.955945ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:35:34.732066Z","caller":"traceutil/trace.go:171","msg":"trace[1720355713] linearizableReadLoop","detail":"{readStateIndex:5669; appliedIndex:5666; }","duration":"116.514676ms","start":"2026-09-18T01:35:34.615521Z","end":"2026-09-18T01:35:34.732035Z","steps":["trace[1720355713] 'read index received' (duration: 61.043518ms)","trace[1720355713] 'applied index is now lower than readState.Index' (duration: 55.469758ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:35:34.732208Z","caller":"traceutil/trace.go:171","msg":"trace[1110978220] transaction","detail":"{read_only:false; response_revision:5457; number_of_response:1; }","duration":"118.131149ms","start":"2026-09-18T01:35:34.614061Z","end":"2026-09-18T01:35:34.732192Z","steps":["trace[1110978220] 'process raft request' (duration: 117.887424ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:35:34.732326Z","caller":"traceutil/trace.go:171","msg":"trace[1134115240] transaction","detail":"{read_only:false; response_revision:5456; number_of_response:1; }","duration":"121.953725ms","start":"2026-09-18T01:35:34.61035Z","end":"2026-09-18T01:35:34.732303Z","steps":["trace[1134115240] 'process raft request' (duration: 121.416145ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:35:34.73261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.005286ms","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-18T01:35:34.732789Z","caller":"traceutil/trace.go:171","msg":"trace[1475390727] 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:5457; }","duration":"117.255881ms","start":"2026-09-18T01:35:34.61548Z","end":"2026-09-18T01:35:34.732736Z","steps":["trace[1475390727] 'agreement among raft nodes before linearized reading' (duration: 116.817572ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:39:21.458666Z","caller":"traceutil/trace.go:171","msg":"trace[1197427802] transaction","detail":"{read_only:false; response_revision:7082; number_of_response:1; }","duration":"155.324ms","start":"2026-09-18T01:39:21.30328Z","end":"2026-09-18T01:39:21.458604Z","steps":["trace[1197427802] 'process raft request' (duration: 154.964747ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:39:49.043773Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4500} {"level":"info","ts":"2026-09-18T01:39:49.09679Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4500,"took":"51.130227ms","hash":3541629567,"current-db-size-bytes":41467904,"current-db-size":"42 MB","current-db-size-in-use-bytes":33386496,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-18T01:39:49.096869Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3541629567,"revision":4500,"compact-revision":2757}