{"level":"warn","ts":"2026-08-13T18:22:55.925014Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T18:22:55.925083Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.191: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.191:2380","--initial-cluster=instance=https://199.19.213.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.191: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-08-13T18:22:55.925137Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T18:22:55.925145Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-08-13T18:22:55.925162Z","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-08-13T18:22:55.925743Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"]} {"level":"info","ts":"2026-08-13T18:22:55.925819Z","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.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.191: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-08-13T18:22:55.930554Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.557895ms"} {"level":"info","ts":"2026-08-13T18:22:55.938563Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e892d50a3a4fc0f4","cluster-id":"21eccdda20ff4e92"} {"level":"info","ts":"2026-08-13T18:22:55.938654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T18:22:55.938683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 0"} {"level":"info","ts":"2026-08-13T18:22:55.938702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e892d50a3a4fc0f4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T18:22:55.938725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 1"} {"level":"info","ts":"2026-08-13T18:22:55.93882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"warn","ts":"2026-08-13T18:22:55.948454Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T18:22:55.950354Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T18:22:55.953392Z","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-08-13T18:22:55.956052Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e892d50a3a4fc0f4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T18:22:55.957015Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e892d50a3a4fc0f4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T18:22:55.957118Z","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-08-13T18:22:55.957163Z","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-08-13T18:22:55.957172Z","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-08-13T18:22:55.958251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"info","ts":"2026-08-13T18:22:55.96082Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","added-peer-id":"e892d50a3a4fc0f4","added-peer-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-08-13T18:22:55.963193Z","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-08-13T18:22:55.963535Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e892d50a3a4fc0f4","initial-advertise-peer-urls":["https://199.19.213.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T18:22:55.963595Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T18:22:55.963324Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-08-13T18:22:55.96382Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-08-13T18:22:56.139924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T18:22:56.139967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T18:22:56.139988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgPreVoteResp from e892d50a3a4fc0f4 at term 1"} {"level":"info","ts":"2026-08-13T18:22:56.139999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became candidate at term 2"} {"level":"info","ts":"2026-08-13T18:22:56.140004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgVoteResp from e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-08-13T18:22:56.140012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became leader at term 2"} {"level":"info","ts":"2026-08-13T18:22:56.14002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e892d50a3a4fc0f4 elected leader e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-08-13T18:22:56.142285Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T18:22:56.144407Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e892d50a3a4fc0f4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.191:2379]}","request-path":"/0/members/e892d50a3a4fc0f4/attributes","cluster-id":"21eccdda20ff4e92","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T18:22:56.144416Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T18:22:56.144561Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T18:22:56.14515Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T18:22:56.145202Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T18:22:56.145407Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T18:22:56.145539Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T18:22:56.14559Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T18:22:56.148494Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.191:2379"} {"level":"info","ts":"2026-08-13T18:22:56.151194Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T18:22:57.797099Z","caller":"traceutil/trace.go:171","msg":"trace[908988159] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:4; }","duration":"332.137589ms","start":"2026-08-13T18:22:57.464924Z","end":"2026-08-13T18:22:57.797062Z","steps":["trace[908988159] 'read index received' (duration: 24.51303ms)","trace[908988159] 'applied index is now lower than readState.Index' (duration: 307.623319ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T18:22:57.797433Z","caller":"traceutil/trace.go:171","msg":"trace[835459429] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"332.639771ms","start":"2026-08-13T18:22:57.464722Z","end":"2026-08-13T18:22:57.797362Z","steps":["trace[835459429] 'process raft request' (duration: 332.266565ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:22:57.797539Z","caller":"traceutil/trace.go:171","msg":"trace[1878455164] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"333.997707ms","start":"2026-08-13T18:22:57.463502Z","end":"2026-08-13T18:22:57.7975Z","steps":["trace[1878455164] 'process raft request' (duration: 333.179402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.797783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.800527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T18:22:57.797895Z","caller":"traceutil/trace.go:171","msg":"trace[1950771459] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:5; }","duration":"332.964384ms","start":"2026-08-13T18:22:57.464907Z","end":"2026-08-13T18:22:57.797871Z","steps":["trace[1950771459] 'agreement among raft nodes before linearized reading' (duration: 332.548347ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.797941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T18:22:57.464796Z","time spent":"333.135991ms","remote":"127.0.0.1:48998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-08-13T18:22:57.798245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T18:22:57.464713Z","time spent":"332.819768ms","remote":"127.0.0.1:48720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T18:22:57.798311Z","caller":"traceutil/trace.go:171","msg":"trace[1802354771] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"333.293667ms","start":"2026-08-13T18:22:57.464983Z","end":"2026-08-13T18:22:57.798276Z","steps":["trace[1802354771] 'process raft request' (duration: 332.050386ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.798441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T18:22:57.463493Z","time spent":"334.228807ms","remote":"127.0.0.1:48794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T18:22:57.798523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T18:22:57.464964Z","time spent":"333.450184ms","remote":"127.0.0.1:48706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T18:22:57.805663Z","caller":"traceutil/trace.go:171","msg":"trace[1635105106] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"265.37306ms","start":"2026-08-13T18:22:57.54028Z","end":"2026-08-13T18:22:57.805653Z","steps":["trace[1635105106] 'process raft request' (duration: 265.036266ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.807152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.540732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T18:22:57.807217Z","caller":"traceutil/trace.go:171","msg":"trace[818702673] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"295.616446ms","start":"2026-08-13T18:22:57.511577Z","end":"2026-08-13T18:22:57.807193Z","steps":["trace[818702673] 'agreement among raft nodes before linearized reading' (duration: 294.829214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.80764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.838446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T18:22:57.807685Z","caller":"traceutil/trace.go:171","msg":"trace[861633880] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"296.891738ms","start":"2026-08-13T18:22:57.510776Z","end":"2026-08-13T18:22:57.807667Z","steps":["trace[861633880] 'agreement among raft nodes before linearized reading' (duration: 296.800284ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.807943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.788866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-m4pds\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-08-13T18:22:57.807979Z","caller":"traceutil/trace.go:171","msg":"trace[1514932509] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-m4pds; range_end:; response_count:1; response_revision:11; }","duration":"315.88522ms","start":"2026-08-13T18:22:57.492076Z","end":"2026-08-13T18:22:57.807961Z","steps":["trace[1514932509] 'agreement among raft nodes before linearized reading' (duration: 315.689972ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.808006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T18:22:57.49206Z","time spent":"315.937471ms","remote":"127.0.0.1:48888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-m4pds\" "} {"level":"warn","ts":"2026-08-13T18:22:57.808725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.135676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T18:22:57.809055Z","caller":"traceutil/trace.go:171","msg":"trace[323200824] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"269.47595ms","start":"2026-08-13T18:22:57.53954Z","end":"2026-08-13T18:22:57.809016Z","steps":["trace[323200824] 'agreement among raft nodes before linearized reading' (duration: 266.31604ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:22:57.809233Z","caller":"traceutil/trace.go:171","msg":"trace[749691492] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"255.116827ms","start":"2026-08-13T18:22:57.550896Z","end":"2026-08-13T18:22:57.806013Z","steps":["trace[749691492] 'process raft request' (duration: 254.540763ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:22:57.809802Z","caller":"traceutil/trace.go:171","msg":"trace[976829847] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"258.628452ms","start":"2026-08-13T18:22:57.551101Z","end":"2026-08-13T18:22:57.809729Z","steps":["trace[976829847] 'process raft request' (duration: 254.349565ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:22:57.810339Z","caller":"traceutil/trace.go:171","msg":"trace[329167701] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"258.685705ms","start":"2026-08-13T18:22:57.551323Z","end":"2026-08-13T18:22:57.810009Z","steps":["trace[329167701] 'process raft request' (duration: 254.148087ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:22:57.810992Z","caller":"traceutil/trace.go:171","msg":"trace[1868869795] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"261.019071ms","start":"2026-08-13T18:22:57.54982Z","end":"2026-08-13T18:22:57.810839Z","steps":["trace[1868869795] 'process raft request' (duration: 255.574286ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.808989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.609905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.191\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T18:22:57.811523Z","caller":"traceutil/trace.go:171","msg":"trace[1641547697] range","detail":"{range_begin:/registry/masterleases/199.19.213.191; range_end:; response_count:0; response_revision:11; }","duration":"272.040706ms","start":"2026-08-13T18:22:57.53934Z","end":"2026-08-13T18:22:57.811381Z","steps":["trace[1641547697] 'agreement among raft nodes before linearized reading' (duration: 266.599311ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:22:57.812175Z","caller":"traceutil/trace.go:171","msg":"trace[1309582719] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"261.987211ms","start":"2026-08-13T18:22:57.550173Z","end":"2026-08-13T18:22:57.812161Z","steps":["trace[1309582719] 'process raft request' (duration: 255.245533ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.812274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.670138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T18:22:57.812299Z","caller":"traceutil/trace.go:171","msg":"trace[807117931] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"270.730911ms","start":"2026-08-13T18:22:57.541561Z","end":"2026-08-13T18:22:57.812291Z","steps":["trace[807117931] 'agreement among raft nodes before linearized reading' (duration: 270.685179ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.812688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.033694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T18:22:57.812763Z","caller":"traceutil/trace.go:171","msg":"trace[1823745773] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"220.128317ms","start":"2026-08-13T18:22:57.592625Z","end":"2026-08-13T18:22:57.812753Z","steps":["trace[1823745773] 'agreement among raft nodes before linearized reading' (duration: 220.039673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.813309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.342117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-08-13T18:22:57.815824Z","caller":"traceutil/trace.go:171","msg":"trace[1978939941] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"350.153971ms","start":"2026-08-13T18:22:57.46495Z","end":"2026-08-13T18:22:57.815104Z","steps":["trace[1978939941] 'agreement among raft nodes before linearized reading' (duration: 340.939932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:22:57.815922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T18:22:57.464925Z","time spent":"350.930123ms","remote":"127.0.0.1:48794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-08-13T18:23:32.298186Z","caller":"traceutil/trace.go:171","msg":"trace[332296449] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"185.270398ms","start":"2026-08-13T18:23:32.112888Z","end":"2026-08-13T18:23:32.298158Z","steps":["trace[332296449] 'process raft request' (duration: 169.696637ms)","trace[332296449] 'compare' (duration: 15.301085ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T18:23:32.29866Z","caller":"traceutil/trace.go:171","msg":"trace[2026458133] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"184.211634ms","start":"2026-08-13T18:23:32.114437Z","end":"2026-08-13T18:23:32.298648Z","steps":["trace[2026458133] 'process raft request' (duration: 183.653302ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:23:32.298725Z","caller":"traceutil/trace.go:171","msg":"trace[1087243997] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"184.094341ms","start":"2026-08-13T18:23:32.114598Z","end":"2026-08-13T18:23:32.298692Z","steps":["trace[1087243997] 'process raft request' (duration: 183.672762ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:23:32.298828Z","caller":"traceutil/trace.go:171","msg":"trace[117020936] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"152.867806ms","start":"2026-08-13T18:23:32.145946Z","end":"2026-08-13T18:23:32.298814Z","steps":["trace[117020936] 'process raft request' (duration: 152.59132ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:23:32.298987Z","caller":"traceutil/trace.go:171","msg":"trace[207999900] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"157.074571ms","start":"2026-08-13T18:23:32.141901Z","end":"2026-08-13T18:23:32.298975Z","steps":["trace[207999900] 'process raft request' (duration: 156.452998ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:23:33.327914Z","caller":"traceutil/trace.go:171","msg":"trace[1270811992] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"116.807678ms","start":"2026-08-13T18:23:33.211075Z","end":"2026-08-13T18:23:33.327883Z","steps":["trace[1270811992] 'process raft request' (duration: 116.015679ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:23:33.32795Z","caller":"traceutil/trace.go:171","msg":"trace[1146452084] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"217.461745ms","start":"2026-08-13T18:23:33.110454Z","end":"2026-08-13T18:23:33.327916Z","steps":["trace[1146452084] 'process raft request' (duration: 201.296213ms)","trace[1146452084] 'compare' (duration: 15.035136ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T18:23:38.690388Z","caller":"traceutil/trace.go:171","msg":"trace[1624352941] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"123.420156ms","start":"2026-08-13T18:23:38.566948Z","end":"2026-08-13T18:23:38.690368Z","steps":["trace[1624352941] 'process raft request' (duration: 122.927085ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:23:39.135532Z","caller":"traceutil/trace.go:171","msg":"trace[954165726] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"384.195738ms","start":"2026-08-13T18:23:38.751298Z","end":"2026-08-13T18:23:39.135494Z","steps":["trace[954165726] 'process raft request' (duration: 383.993554ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:23:39.135708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T18:23:38.751272Z","time spent":"384.358622ms","remote":"127.0.0.1:49098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T18:23:39.262096Z","caller":"traceutil/trace.go:171","msg":"trace[688636349] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"104.791748ms","start":"2026-08-13T18:23:39.157284Z","end":"2026-08-13T18:23:39.262076Z","steps":["trace[688636349] 'process raft request' (duration: 85.394725ms)","trace[688636349] 'compare' (duration: 19.040836ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T18:23:54.641157Z","caller":"traceutil/trace.go:171","msg":"trace[1052604958] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"226.86978ms","start":"2026-08-13T18:23:54.414256Z","end":"2026-08-13T18:23:54.641126Z","steps":["trace[1052604958] 'process raft request' (duration: 226.664967ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:23:54.685832Z","caller":"traceutil/trace.go:171","msg":"trace[1802020911] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"268.086062ms","start":"2026-08-13T18:23:54.417718Z","end":"2026-08-13T18:23:54.685804Z","steps":["trace[1802020911] 'process raft request' (duration: 261.497413ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:25:08.521937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.414583ms","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-08-13T18:25:08.522033Z","caller":"traceutil/trace.go:171","msg":"trace[1196846698] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1857; }","duration":"204.577473ms","start":"2026-08-13T18:25:08.317436Z","end":"2026-08-13T18:25:08.522013Z","steps":["trace[1196846698] 'range keys from in-memory index tree' (duration: 204.230641ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:25:08.839242Z","caller":"traceutil/trace.go:171","msg":"trace[879798404] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"224.146057ms","start":"2026-08-13T18:25:08.615069Z","end":"2026-08-13T18:25:08.839215Z","steps":["trace[879798404] 'process raft request' (duration: 223.929095ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:25:08.886244Z","caller":"traceutil/trace.go:171","msg":"trace[808068383] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1931; }","duration":"170.950239ms","start":"2026-08-13T18:25:08.715264Z","end":"2026-08-13T18:25:08.886215Z","steps":["trace[808068383] 'read index received' (duration: 123.769956ms)","trace[808068383] 'applied index is now lower than readState.Index' (duration: 47.179043ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T18:25:08.886441Z","caller":"traceutil/trace.go:171","msg":"trace[40365762] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"194.177903ms","start":"2026-08-13T18:25:08.692234Z","end":"2026-08-13T18:25:08.886412Z","steps":["trace[40365762] 'process raft request' (duration: 193.848561ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:25:08.886579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.21256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T18:25:08.886629Z","caller":"traceutil/trace.go:171","msg":"trace[97761310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1860; }","duration":"171.421571ms","start":"2026-08-13T18:25:08.715195Z","end":"2026-08-13T18:25:08.886617Z","steps":["trace[97761310] 'agreement among raft nodes before linearized reading' (duration: 171.121369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:25:38.272441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.711513ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T18:25:38.272546Z","caller":"traceutil/trace.go:171","msg":"trace[261063652] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"171.327247ms","start":"2026-08-13T18:25:38.101208Z","end":"2026-08-13T18:25:38.272535Z","steps":["trace[261063652] 'process raft request' (duration: 171.297446ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:25:38.272679Z","caller":"traceutil/trace.go:171","msg":"trace[43501488] transaction","detail":"{read_only:false; response_revision:2081; number_of_response:1; }","duration":"201.569693ms","start":"2026-08-13T18:25:38.071089Z","end":"2026-08-13T18:25:38.272659Z","steps":["trace[43501488] 'process raft request' (duration: 83.511316ms)","trace[43501488] 'compare' (duration: 117.636792ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T18:25:38.315996Z","caller":"traceutil/trace.go:171","msg":"trace[2108518229] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"157.418475ms","start":"2026-08-13T18:25:38.158561Z","end":"2026-08-13T18:25:38.315979Z","steps":["trace[2108518229] 'process raft request' (duration: 157.091863ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:27:28.670583Z","caller":"traceutil/trace.go:171","msg":"trace[1295663855] transaction","detail":"{read_only:false; response_revision:2778; number_of_response:1; }","duration":"111.742197ms","start":"2026-08-13T18:27:28.558822Z","end":"2026-08-13T18:27:28.670564Z","steps":["trace[1295663855] 'process raft request' (duration: 111.624545ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:27:28.681046Z","caller":"traceutil/trace.go:171","msg":"trace[1810383671] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"106.491919ms","start":"2026-08-13T18:27:28.574532Z","end":"2026-08-13T18:27:28.681024Z","steps":["trace[1810383671] 'process raft request' (duration: 106.335067ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:27:28.890805Z","caller":"traceutil/trace.go:171","msg":"trace[1911985219] transaction","detail":"{read_only:false; response_revision:2780; number_of_response:1; }","duration":"218.724691ms","start":"2026-08-13T18:27:28.672037Z","end":"2026-08-13T18:27:28.890762Z","steps":["trace[1911985219] 'process raft request' (duration: 144.82965ms)","trace[1911985219] 'compare' (duration: 73.087102ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T18:27:28.890839Z","caller":"traceutil/trace.go:171","msg":"trace[1927535064] linearizableReadLoop","detail":"{readStateIndex:2886; appliedIndex:2883; }","duration":"176.664728ms","start":"2026-08-13T18:27:28.714145Z","end":"2026-08-13T18:27:28.89081Z","steps":["trace[1927535064] 'read index received' (duration: 102.667965ms)","trace[1927535064] 'applied index is now lower than readState.Index' (duration: 73.995333ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T18:27:28.890874Z","caller":"traceutil/trace.go:171","msg":"trace[118539920] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"216.669948ms","start":"2026-08-13T18:27:28.674177Z","end":"2026-08-13T18:27:28.890847Z","steps":["trace[118539920] 'process raft request' (duration: 216.461846ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T18:27:28.890973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.805459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T18:27:28.891029Z","caller":"traceutil/trace.go:171","msg":"trace[1548633871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2782; }","duration":"176.901811ms","start":"2026-08-13T18:27:28.714115Z","end":"2026-08-13T18:27:28.891017Z","steps":["trace[1548633871] 'agreement among raft nodes before linearized reading' (duration: 176.79661ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:27:28.891658Z","caller":"traceutil/trace.go:171","msg":"trace[1049882640] transaction","detail":"{read_only:false; response_revision:2782; number_of_response:1; }","duration":"214.488263ms","start":"2026-08-13T18:27:28.676378Z","end":"2026-08-13T18:27:28.890866Z","steps":["trace[1049882640] 'process raft request' (duration: 214.364792ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:31:11.478993Z","caller":"traceutil/trace.go:171","msg":"trace[1476405109] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"113.820932ms","start":"2026-08-13T18:31:11.365142Z","end":"2026-08-13T18:31:11.478963Z","steps":["trace[1476405109] 'process raft request' (duration: 59.746118ms)","trace[1476405109] 'compare' (duration: 53.93935ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T18:31:18.537625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.735957ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T18:31:18.537727Z","caller":"traceutil/trace.go:171","msg":"trace[136668995] transaction","detail":"{read_only:false; response_revision:4811; number_of_response:1; }","duration":"116.855598ms","start":"2026-08-13T18:31:18.420855Z","end":"2026-08-13T18:31:18.537711Z","steps":["trace[136668995] 'compare' (duration: 106.404849ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T18:32:56.274209Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2926} {"level":"info","ts":"2026-08-13T18:32:56.384686Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2926,"took":"109.100327ms","hash":78512636,"current-db-size-bytes":53846016,"current-db-size":"54 MB","current-db-size-in-use-bytes":29470720,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-13T18:32:56.384759Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":78512636,"revision":2926,"compact-revision":-1} {"level":"info","ts":"2026-08-13T18:37:56.280031Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5607} {"level":"info","ts":"2026-08-13T18:37:56.380586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5607,"took":"98.986374ms","hash":4067773595,"current-db-size-bytes":53846016,"current-db-size":"54 MB","current-db-size-in-use-bytes":18255872,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-13T18:37:56.380664Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4067773595,"revision":5607,"compact-revision":2926}