{"level":"warn","ts":"2026-07-16T09:44:02.675021Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T09:44:02.675099Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.153: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://199.19.213.153:2380","--initial-cluster=instance=https://199.19.213.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.153: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-07-16T09:44:02.67516Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T09:44:02.675168Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.153:2380"]} {"level":"info","ts":"2026-07-16T09:44:02.675185Z","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-07-16T09:44:02.676408Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.153:2379"]} {"level":"info","ts":"2026-07-16T09:44:02.676495Z","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://199.19.213.153:2380"],"listen-peer-urls":["https://199.19.213.153:2380"],"advertise-client-urls":["https://199.19.213.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.153: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-07-16T09:44:02.682876Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.254988ms"} {"level":"info","ts":"2026-07-16T09:44:02.69085Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"36b63984d68b7065","cluster-id":"7c251967b436417d"} {"level":"info","ts":"2026-07-16T09:44:02.690912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 switched to configuration voters=()"} {"level":"info","ts":"2026-07-16T09:44:02.691002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became follower at term 0"} {"level":"info","ts":"2026-07-16T09:44:02.69101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 36b63984d68b7065 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-16T09:44:02.691065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became follower at term 1"} {"level":"info","ts":"2026-07-16T09:44:02.691128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 switched to configuration voters=(3942401766507376741)"} {"level":"warn","ts":"2026-07-16T09:44:02.712657Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-16T09:44:02.748544Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-16T09:44:02.839689Z","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-07-16T09:44:02.846639Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"36b63984d68b7065","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-16T09:44:02.846958Z","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-07-16T09:44:02.846925Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"36b63984d68b7065","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-16T09:44:02.847038Z","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-07-16T09:44:02.847059Z","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-07-16T09:44:02.849609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 switched to configuration voters=(3942401766507376741)"} {"level":"info","ts":"2026-07-16T09:44:02.849837Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7c251967b436417d","local-member-id":"36b63984d68b7065","added-peer-id":"36b63984d68b7065","added-peer-peer-urls":["https://199.19.213.153:2380"]} {"level":"info","ts":"2026-07-16T09:44:02.85282Z","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-07-16T09:44:02.852945Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.153:2380"} {"level":"info","ts":"2026-07-16T09:44:02.853005Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.153:2380"} {"level":"info","ts":"2026-07-16T09:44:02.853183Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"36b63984d68b7065","initial-advertise-peer-urls":["https://199.19.213.153:2380"],"listen-peer-urls":["https://199.19.213.153:2380"],"advertise-client-urls":["https://199.19.213.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-16T09:44:02.853236Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-16T09:44:03.291631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 is starting a new election at term 1"} {"level":"info","ts":"2026-07-16T09:44:03.291769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-16T09:44:03.29183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 received MsgPreVoteResp from 36b63984d68b7065 at term 1"} {"level":"info","ts":"2026-07-16T09:44:03.29188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became candidate at term 2"} {"level":"info","ts":"2026-07-16T09:44:03.291924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 received MsgVoteResp from 36b63984d68b7065 at term 2"} {"level":"info","ts":"2026-07-16T09:44:03.292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became leader at term 2"} {"level":"info","ts":"2026-07-16T09:44:03.292039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 36b63984d68b7065 elected leader 36b63984d68b7065 at term 2"} {"level":"info","ts":"2026-07-16T09:44:03.292848Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"36b63984d68b7065","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.153:2379]}","request-path":"/0/members/36b63984d68b7065/attributes","cluster-id":"7c251967b436417d","publish-timeout":"7s"} {"level":"info","ts":"2026-07-16T09:44:03.293465Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T09:44:03.293841Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T09:44:03.293982Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T09:44:03.294246Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-16T09:44:03.294285Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-16T09:44:03.294796Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7c251967b436417d","local-member-id":"36b63984d68b7065","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T09:44:03.294924Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T09:44:03.294961Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T09:44:03.300709Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-16T09:44:03.309968Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.153:2379"} {"level":"info","ts":"2026-07-16T09:44:07.400032Z","caller":"traceutil/trace.go:171","msg":"trace[905503500] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"200.998129ms","start":"2026-07-16T09:44:07.199004Z","end":"2026-07-16T09:44:07.400002Z","steps":["trace[905503500] 'process raft request' (duration: 200.797617ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:44:08.027778Z","caller":"traceutil/trace.go:171","msg":"trace[618881543] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"189.473033ms","start":"2026-07-16T09:44:07.838287Z","end":"2026-07-16T09:44:08.02776Z","steps":["trace[618881543] 'process raft request' (duration: 115.62313ms)","trace[618881543] 'compare' (duration: 73.656971ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T09:44:08.027781Z","caller":"traceutil/trace.go:171","msg":"trace[1842350054] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"125.74683ms","start":"2026-07-16T09:44:07.902007Z","end":"2026-07-16T09:44:08.027754Z","steps":["trace[1842350054] 'process raft request' (duration: 125.693027ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:44:08.028022Z","caller":"traceutil/trace.go:171","msg":"trace[1098452277] linearizableReadLoop","detail":"{readStateIndex:273; appliedIndex:272; }","duration":"189.349506ms","start":"2026-07-16T09:44:07.83865Z","end":"2026-07-16T09:44:08.027999Z","steps":["trace[1098452277] 'read index received' (duration: 115.262207ms)","trace[1098452277] 'applied index is now lower than readState.Index' (duration: 74.085268ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T09:44:08.028207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.539728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T09:44:08.02826Z","caller":"traceutil/trace.go:171","msg":"trace[1833557481] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:268; }","duration":"189.624863ms","start":"2026-07-16T09:44:07.838626Z","end":"2026-07-16T09:44:08.028251Z","steps":["trace[1833557481] 'agreement among raft nodes before linearized reading' (duration: 189.514487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:44:08.033752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.717257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T09:44:08.033788Z","caller":"traceutil/trace.go:171","msg":"trace[656038561] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:272; }","duration":"133.784431ms","start":"2026-07-16T09:44:07.899995Z","end":"2026-07-16T09:44:08.03378Z","steps":["trace[656038561] 'agreement among raft nodes before linearized reading' (duration: 133.706687ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:44:08.033864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.185594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-07-16T09:44:08.033907Z","caller":"traceutil/trace.go:171","msg":"trace[1878181244] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:272; }","duration":"133.28554ms","start":"2026-07-16T09:44:07.900611Z","end":"2026-07-16T09:44:08.033896Z","steps":["trace[1878181244] 'agreement among raft nodes before linearized reading' (duration: 133.175423ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:44:43.967498Z","caller":"traceutil/trace.go:171","msg":"trace[1224493951] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"121.53698ms","start":"2026-07-16T09:44:43.845915Z","end":"2026-07-16T09:44:43.967452Z","steps":["trace[1224493951] 'process raft request' (duration: 120.85409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:44:44.16015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.40124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zqdvq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-16T09:44:44.160209Z","caller":"traceutil/trace.go:171","msg":"trace[1118980137] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"123.351135ms","start":"2026-07-16T09:44:44.036823Z","end":"2026-07-16T09:44:44.160174Z","steps":["trace[1118980137] 'process raft request' (duration: 57.764707ms)","trace[1118980137] 'compare' (duration: 65.323298ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T09:44:44.160271Z","caller":"traceutil/trace.go:171","msg":"trace[719239142] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zqdvq; range_end:; response_count:1; response_revision:630; }","duration":"133.556721ms","start":"2026-07-16T09:44:44.026681Z","end":"2026-07-16T09:44:44.160238Z","steps":["trace[719239142] 'range keys from in-memory index tree' (duration: 133.110129ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:44:44.329368Z","caller":"traceutil/trace.go:171","msg":"trace[268728237] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"154.637866ms","start":"2026-07-16T09:44:44.174696Z","end":"2026-07-16T09:44:44.329334Z","steps":["trace[268728237] 'process raft request' (duration: 153.950596ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:44:44.670645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.860181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T09:44:44.670742Z","caller":"traceutil/trace.go:171","msg":"trace[697916340] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"332.2934ms","start":"2026-07-16T09:44:44.338435Z","end":"2026-07-16T09:44:44.670728Z","steps":["trace[697916340] 'process raft request' (duration: 84.815064ms)","trace[697916340] 'compare' (duration: 246.645614ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T09:44:44.670788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T09:44:44.338404Z","time spent":"332.361966ms","remote":"127.0.0.1:52130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T09:44:45.265934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.660986ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T09:44:45.266077Z","caller":"traceutil/trace.go:171","msg":"trace[1121269944] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"452.579708ms","start":"2026-07-16T09:44:44.813471Z","end":"2026-07-16T09:44:45.26605Z","steps":["trace[1121269944] 'read index received' (duration: 102.871934ms)","trace[1121269944] 'applied index is now lower than readState.Index' (duration: 349.706514ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T09:44:45.26625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.01871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-16T09:44:45.266333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.358312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-16T09:44:45.266371Z","caller":"traceutil/trace.go:171","msg":"trace[527484982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"445.45661ms","start":"2026-07-16T09:44:44.820905Z","end":"2026-07-16T09:44:45.266361Z","steps":["trace[527484982] 'agreement among raft nodes before linearized reading' (duration: 445.275947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:44:45.266347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.852529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-16T09:44:45.266423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T09:44:44.820869Z","time spent":"445.545506ms","remote":"127.0.0.1:52130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-16T09:44:45.266441Z","caller":"traceutil/trace.go:171","msg":"trace[1175970892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"453.016211ms","start":"2026-07-16T09:44:44.8134Z","end":"2026-07-16T09:44:45.266416Z","steps":["trace[1175970892] 'agreement among raft nodes before linearized reading' (duration: 452.757552ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:44:45.266489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T09:44:44.813372Z","time spent":"453.109438ms","remote":"127.0.0.1:52130","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":"warn","ts":"2026-07-16T09:44:45.26663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.500018ms","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-07-16T09:44:45.266745Z","caller":"traceutil/trace.go:171","msg":"trace[1586417082] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"287.67745ms","start":"2026-07-16T09:44:44.979039Z","end":"2026-07-16T09:44:45.266716Z","steps":["trace[1586417082] 'agreement among raft nodes before linearized reading' (duration: 287.329734ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:44:45.266396Z","caller":"traceutil/trace.go:171","msg":"trace[847783656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"162.170381ms","start":"2026-07-16T09:44:45.104164Z","end":"2026-07-16T09:44:45.266334Z","steps":["trace[847783656] 'agreement among raft nodes before linearized reading' (duration: 162.02792ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:44:45.266528Z","caller":"traceutil/trace.go:171","msg":"trace[1474382732] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"645.384618ms","start":"2026-07-16T09:44:44.621071Z","end":"2026-07-16T09:44:45.266455Z","steps":["trace[1474382732] 'process raft request' (duration: 296.085834ms)","trace[1474382732] 'compare' (duration: 347.741108ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T09:44:45.268103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T09:44:44.621026Z","time spent":"647.004628ms","remote":"127.0.0.1:51968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T09:45:00.913724Z","caller":"traceutil/trace.go:171","msg":"trace[2057228009] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"160.78101ms","start":"2026-07-16T09:45:00.752896Z","end":"2026-07-16T09:45:00.913677Z","steps":["trace[2057228009] 'process raft request' (duration: 121.54052ms)","trace[2057228009] 'compare' (duration: 39.05046ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T09:46:27.423259Z","caller":"traceutil/trace.go:171","msg":"trace[1794210714] linearizableReadLoop","detail":"{readStateIndex:1977; appliedIndex:1976; }","duration":"154.270652ms","start":"2026-07-16T09:46:27.268956Z","end":"2026-07-16T09:46:27.423226Z","steps":["trace[1794210714] 'read index received' (duration: 154.015863ms)","trace[1794210714] 'applied index is now lower than readState.Index' (duration: 253.659µs)"],"step_count":2} {"level":"warn","ts":"2026-07-16T09:46:27.423794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.301378ms","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-07-16T09:46:27.423836Z","caller":"traceutil/trace.go:171","msg":"trace[1060775089] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1906; }","duration":"128.35718ms","start":"2026-07-16T09:46:27.295467Z","end":"2026-07-16T09:46:27.423824Z","steps":["trace[1060775089] 'agreement among raft nodes before linearized reading' (duration: 128.251126ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:46:27.423384Z","caller":"traceutil/trace.go:171","msg":"trace[1098677968] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"166.55204ms","start":"2026-07-16T09:46:27.256781Z","end":"2026-07-16T09:46:27.423333Z","steps":["trace[1098677968] 'process raft request' (duration: 166.26697ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:46:27.4236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.601543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8685db21-da36-4e6b-bdc2-152f5a2397aa\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-16T09:46:27.424146Z","caller":"traceutil/trace.go:171","msg":"trace[1708427120] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8685db21-da36-4e6b-bdc2-152f5a2397aa; range_end:; response_count:1; response_revision:1906; }","duration":"155.186103ms","start":"2026-07-16T09:46:27.268934Z","end":"2026-07-16T09:46:27.42412Z","steps":["trace[1708427120] 'agreement among raft nodes before linearized reading' (duration: 154.469279ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:46:27.535229Z","caller":"traceutil/trace.go:171","msg":"trace[1289846039] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"104.792117ms","start":"2026-07-16T09:46:27.430371Z","end":"2026-07-16T09:46:27.535163Z","steps":["trace[1289846039] 'process raft request' (duration: 104.490317ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:46:40.133211Z","caller":"traceutil/trace.go:171","msg":"trace[1223916096] linearizableReadLoop","detail":"{readStateIndex:2089; appliedIndex:2088; }","duration":"115.739705ms","start":"2026-07-16T09:46:40.017448Z","end":"2026-07-16T09:46:40.133187Z","steps":["trace[1223916096] 'read index received' (duration: 115.524027ms)","trace[1223916096] 'applied index is now lower than readState.Index' (duration: 214.578µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T09:46:40.133265Z","caller":"traceutil/trace.go:171","msg":"trace[1066327386] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"121.048465ms","start":"2026-07-16T09:46:40.012176Z","end":"2026-07-16T09:46:40.133225Z","steps":["trace[1066327386] 'process raft request' (duration: 120.826737ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:46:40.133535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.039557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-16T09:46:40.133572Z","caller":"traceutil/trace.go:171","msg":"trace[479936549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2015; }","duration":"116.141441ms","start":"2026-07-16T09:46:40.017421Z","end":"2026-07-16T09:46:40.133563Z","steps":["trace[479936549] 'agreement among raft nodes before linearized reading' (duration: 115.948673ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:46:40.279627Z","caller":"traceutil/trace.go:171","msg":"trace[1081725996] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"134.985608ms","start":"2026-07-16T09:46:40.144611Z","end":"2026-07-16T09:46:40.279597Z","steps":["trace[1081725996] 'process raft request' (duration: 118.695132ms)","trace[1081725996] 'compare' (duration: 16.13794ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T09:46:40.475021Z","caller":"traceutil/trace.go:171","msg":"trace[1181274905] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"189.382573ms","start":"2026-07-16T09:46:40.285591Z","end":"2026-07-16T09:46:40.474973Z","steps":["trace[1181274905] 'process raft request' (duration: 156.701337ms)","trace[1181274905] 'compare' (duration: 32.347013ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T09:46:40.47519Z","caller":"traceutil/trace.go:171","msg":"trace[1544464619] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"189.491867ms","start":"2026-07-16T09:46:40.285663Z","end":"2026-07-16T09:46:40.475155Z","steps":["trace[1544464619] 'process raft request' (duration: 189.136413ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:46:40.475685Z","caller":"traceutil/trace.go:171","msg":"trace[517145719] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"186.837241ms","start":"2026-07-16T09:46:40.288797Z","end":"2026-07-16T09:46:40.475634Z","steps":["trace[517145719] 'process raft request' (duration: 186.129693ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:47:06.913884Z","caller":"traceutil/trace.go:171","msg":"trace[257347032] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"100.023687ms","start":"2026-07-16T09:47:06.81383Z","end":"2026-07-16T09:47:06.913853Z","steps":["trace[257347032] 'process raft request' (duration: 27.624262ms)","trace[257347032] 'compare' (duration: 72.062918ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T09:47:06.914233Z","caller":"traceutil/trace.go:171","msg":"trace[1258088612] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"100.117361ms","start":"2026-07-16T09:47:06.814078Z","end":"2026-07-16T09:47:06.914195Z","steps":["trace[1258088612] 'process raft request' (duration: 99.633478ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:47:07.868746Z","caller":"traceutil/trace.go:171","msg":"trace[1785038459] linearizableReadLoop","detail":"{readStateIndex:2253; appliedIndex:2252; }","duration":"145.51838ms","start":"2026-07-16T09:47:07.723197Z","end":"2026-07-16T09:47:07.868715Z","steps":["trace[1785038459] 'read index received' (duration: 145.264018ms)","trace[1785038459] 'applied index is now lower than readState.Index' (duration: 253.632µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T09:47:07.868837Z","caller":"traceutil/trace.go:171","msg":"trace[1805425200] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"146.193023ms","start":"2026-07-16T09:47:07.722604Z","end":"2026-07-16T09:47:07.868797Z","steps":["trace[1805425200] 'process raft request' (duration: 145.940071ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:47:07.869022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.768984ms","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-07-16T09:47:07.869065Z","caller":"traceutil/trace.go:171","msg":"trace[330897843] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2173; }","duration":"145.898359ms","start":"2026-07-16T09:47:07.723154Z","end":"2026-07-16T09:47:07.869052Z","steps":["trace[330897843] 'agreement among raft nodes before linearized reading' (duration: 145.677738ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:48:31.000024Z","caller":"traceutil/trace.go:171","msg":"trace[1218676975] transaction","detail":"{read_only:false; response_revision:2733; number_of_response:1; }","duration":"193.072075ms","start":"2026-07-16T09:48:30.806917Z","end":"2026-07-16T09:48:30.999989Z","steps":["trace[1218676975] 'process raft request' (duration: 161.913662ms)","trace[1218676975] 'compare' (duration: 30.825723ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T09:52:21.000435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.841319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-07-16T09:52:21.000555Z","caller":"traceutil/trace.go:171","msg":"trace[616949371] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4563; }","duration":"113.014533ms","start":"2026-07-16T09:52:20.887515Z","end":"2026-07-16T09:52:21.00053Z","steps":["trace[616949371] 'range keys from in-memory index tree' (duration: 112.641253ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:52:22.727253Z","caller":"traceutil/trace.go:171","msg":"trace[1164012350] transaction","detail":"{read_only:false; response_revision:4600; number_of_response:1; }","duration":"124.794748ms","start":"2026-07-16T09:52:22.602424Z","end":"2026-07-16T09:52:22.727219Z","steps":["trace[1164012350] 'process raft request' (duration: 114.88024ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:52:29.523608Z","caller":"traceutil/trace.go:171","msg":"trace[988412403] linearizableReadLoop","detail":"{readStateIndex:4877; appliedIndex:4876; }","duration":"145.760439ms","start":"2026-07-16T09:52:29.377786Z","end":"2026-07-16T09:52:29.523546Z","steps":["trace[988412403] 'read index received' (duration: 145.436429ms)","trace[988412403] 'applied index is now lower than readState.Index' (duration: 322.64µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T09:52:29.524278Z","caller":"traceutil/trace.go:171","msg":"trace[626152624] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"226.642074ms","start":"2026-07-16T09:52:29.297569Z","end":"2026-07-16T09:52:29.524211Z","steps":["trace[626152624] 'process raft request' (duration: 225.771427ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:52:29.524697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.885085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-07-16T09:52:29.524761Z","caller":"traceutil/trace.go:171","msg":"trace[703053649] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4700; }","duration":"147.034098ms","start":"2026-07-16T09:52:29.377712Z","end":"2026-07-16T09:52:29.524746Z","steps":["trace[703053649] 'agreement among raft nodes before linearized reading' (duration: 146.001537ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:52:29.689859Z","caller":"traceutil/trace.go:171","msg":"trace[820498691] linearizableReadLoop","detail":"{readStateIndex:4882; appliedIndex:4881; }","duration":"106.535405ms","start":"2026-07-16T09:52:29.583297Z","end":"2026-07-16T09:52:29.689833Z","steps":["trace[820498691] 'read index received' (duration: 102.156308ms)","trace[820498691] 'applied index is now lower than readState.Index' (duration: 4.377897ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T09:52:29.689999Z","caller":"traceutil/trace.go:171","msg":"trace[432698754] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"112.918214ms","start":"2026-07-16T09:52:29.577071Z","end":"2026-07-16T09:52:29.689989Z","steps":["trace[432698754] 'process raft request' (duration: 108.533497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:52:29.690643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.312399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-07-16T09:52:29.690678Z","caller":"traceutil/trace.go:171","msg":"trace[1294271696] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4705; }","duration":"107.425223ms","start":"2026-07-16T09:52:29.583242Z","end":"2026-07-16T09:52:29.690667Z","steps":["trace[1294271696] 'agreement among raft nodes before linearized reading' (duration: 107.157805ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:52:29.6911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.457681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-68dcdf44f-krfmw.18c2bc65fa4f3cb2\" ","response":"range_response_count:1 size:893"} {"level":"info","ts":"2026-07-16T09:52:29.69114Z","caller":"traceutil/trace.go:171","msg":"trace[1344730569] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-68dcdf44f-krfmw.18c2bc65fa4f3cb2; range_end:; response_count:1; response_revision:4705; }","duration":"105.512513ms","start":"2026-07-16T09:52:29.585617Z","end":"2026-07-16T09:52:29.691129Z","steps":["trace[1344730569] 'agreement among raft nodes before linearized reading' (duration: 105.392508ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T09:52:29.691516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.91797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-07-16T09:52:29.69155Z","caller":"traceutil/trace.go:171","msg":"trace[821440232] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4705; }","duration":"100.981762ms","start":"2026-07-16T09:52:29.590556Z","end":"2026-07-16T09:52:29.691538Z","steps":["trace[821440232] 'agreement among raft nodes before linearized reading' (duration: 100.892899ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:53:30.694561Z","caller":"traceutil/trace.go:171","msg":"trace[1994123270] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"106.720321ms","start":"2026-07-16T09:53:30.587807Z","end":"2026-07-16T09:53:30.694528Z","steps":["trace[1994123270] 'process raft request' (duration: 97.801141ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T09:54:03.318396Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2904} {"level":"info","ts":"2026-07-16T09:54:03.417869Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2904,"took":"95.530615ms","hash":3601312319,"current-db-size-bytes":53153792,"current-db-size":"53 MB","current-db-size-in-use-bytes":29306880,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-16T09:54:03.41796Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3601312319,"revision":2904,"compact-revision":-1} {"level":"info","ts":"2026-07-16T09:59:03.323777Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5575} {"level":"info","ts":"2026-07-16T09:59:03.425454Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5575,"took":"99.705765ms","hash":3945147022,"current-db-size-bytes":53153792,"current-db-size":"53 MB","current-db-size-in-use-bytes":18186240,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-16T09:59:03.425517Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3945147022,"revision":5575,"compact-revision":2904}