{"level":"warn","ts":"2026-07-29T15:40:16.332987Z","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-29T15:40:16.333123Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.25: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.25:2380","--initial-cluster=instance=https://199.19.213.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.25: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-29T15:40:16.333242Z","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-29T15:40:16.333259Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-07-29T15:40:16.333295Z","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-29T15:40:16.334118Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"]} {"level":"info","ts":"2026-07-29T15:40:16.334233Z","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.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.25: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-29T15:40:16.340497Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.987656ms"} {"level":"info","ts":"2026-07-29T15:40:16.349486Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd4db28c48efaf1","cluster-id":"b621f59192c78404"} {"level":"info","ts":"2026-07-29T15:40:16.34956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-29T15:40:16.349587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 0"} {"level":"info","ts":"2026-07-29T15:40:16.349603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd4db28c48efaf1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-29T15:40:16.349628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 1"} {"level":"info","ts":"2026-07-29T15:40:16.349676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"warn","ts":"2026-07-29T15:40:16.362908Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-29T15:40:16.36427Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-29T15:40:16.365241Z","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-29T15:40:16.36694Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd4db28c48efaf1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-29T15:40:16.368569Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd4db28c48efaf1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-29T15:40:16.368628Z","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-29T15:40:16.368661Z","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-29T15:40:16.368669Z","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-29T15:40:16.373402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"info","ts":"2026-07-29T15:40:16.373534Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","added-peer-id":"9bd4db28c48efaf1","added-peer-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-07-29T15:40:16.374862Z","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-29T15:40:16.37495Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-07-29T15:40:16.374967Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-07-29T15:40:16.375128Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd4db28c48efaf1","initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-29T15:40:16.37517Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-29T15:40:17.150305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-29T15:40:17.150428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-29T15:40:17.150459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgPreVoteResp from 9bd4db28c48efaf1 at term 1"} {"level":"info","ts":"2026-07-29T15:40:17.150496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became candidate at term 2"} {"level":"info","ts":"2026-07-29T15:40:17.150509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgVoteResp from 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-07-29T15:40:17.150527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became leader at term 2"} {"level":"info","ts":"2026-07-29T15:40:17.150542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd4db28c48efaf1 elected leader 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-07-29T15:40:17.151845Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T15:40:17.1529Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd4db28c48efaf1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.25:2379]}","request-path":"/0/members/9bd4db28c48efaf1/attributes","cluster-id":"b621f59192c78404","publish-timeout":"7s"} {"level":"info","ts":"2026-07-29T15:40:17.153051Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T15:40:17.153142Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T15:40:17.153695Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T15:40:17.153864Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T15:40:17.153916Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T15:40:17.156251Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.25:2379"} {"level":"info","ts":"2026-07-29T15:40:17.156474Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-29T15:40:17.156519Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-29T15:40:17.156606Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-29T15:40:19.214181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.018115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.25\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-29T15:40:19.214216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.962847ms","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-07-29T15:40:19.214317Z","caller":"traceutil/trace.go:171","msg":"trace[1950033949] range","detail":"{range_begin:/registry/masterleases/199.19.213.25; range_end:; response_count:0; response_revision:4; }","duration":"633.266383ms","start":"2026-07-29T15:40:18.581027Z","end":"2026-07-29T15:40:19.214293Z","steps":["trace[1950033949] 'range keys from in-memory index tree' (duration: 632.918262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:19.214311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.776221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-29T15:40:19.214374Z","caller":"traceutil/trace.go:171","msg":"trace[1053176031] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:4; }","duration":"631.167322ms","start":"2026-07-29T15:40:18.583167Z","end":"2026-07-29T15:40:19.214334Z","steps":["trace[1053176031] 'range keys from in-memory index tree' (duration: 630.875772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:19.214387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.581011Z","time spent":"633.364866ms","remote":"127.0.0.1:58318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.19.213.25\" "} {"level":"info","ts":"2026-07-29T15:40:19.214437Z","caller":"traceutil/trace.go:171","msg":"trace[410778412] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:4; }","duration":"640.936067ms","start":"2026-07-29T15:40:18.573446Z","end":"2026-07-29T15:40:19.214382Z","steps":["trace[410778412] 'range keys from in-memory index tree' (duration: 640.660269ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:19.214463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.583157Z","time spent":"631.283335ms","remote":"127.0.0.1:58362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-07-29T15:40:19.214504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.573418Z","time spent":"641.075992ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-29T15:40:19.214695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.301687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-29T15:40:19.214808Z","caller":"traceutil/trace.go:171","msg":"trace[1869084233] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:4; }","duration":"631.4403ms","start":"2026-07-29T15:40:18.583343Z","end":"2026-07-29T15:40:19.214784Z","steps":["trace[1869084233] 'range keys from in-memory index tree' (duration: 631.199562ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:19.214741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.112433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-29T15:40:19.214861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.583312Z","time spent":"631.538303ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-29T15:40:19.214884Z","caller":"traceutil/trace.go:171","msg":"trace[207940477] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:4; }","duration":"641.320208ms","start":"2026-07-29T15:40:18.573536Z","end":"2026-07-29T15:40:19.214856Z","steps":["trace[207940477] 'range keys from in-memory index tree' (duration: 641.05072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:19.214958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.573527Z","time spent":"641.4189ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-29T15:40:19.215683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.39177ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-29T15:40:19.215845Z","caller":"traceutil/trace.go:171","msg":"trace[640145182] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"632.224952ms","start":"2026-07-29T15:40:18.583599Z","end":"2026-07-29T15:40:19.215824Z","steps":["trace[640145182] 'process raft request' (duration: 323.877025ms)","trace[640145182] 'compare' (duration: 306.555685ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:40:19.215911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.58356Z","time spent":"632.323586ms","remote":"127.0.0.1:58814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T15:40:20.018815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.400752ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-29T15:40:20.019126Z","caller":"traceutil/trace.go:171","msg":"trace[782301867] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"799.614478ms","start":"2026-07-29T15:40:19.219499Z","end":"2026-07-29T15:40:20.019113Z","steps":["trace[782301867] 'process raft request' (duration: 799.542617ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:20.019175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:19.219481Z","time spent":"799.677711ms","remote":"127.0.0.1:58814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T15:40:20.019235Z","caller":"traceutil/trace.go:171","msg":"trace[193213277] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.435504709s","start":"2026-07-29T15:40:18.583708Z","end":"2026-07-29T15:40:20.019213Z","steps":["trace[193213277] 'process raft request' (duration: 777.651285ms)","trace[193213277] 'compare' (duration: 657.293108ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:40:20.019262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.583679Z","time spent":"1.435570901s","remote":"127.0.0.1:58814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T15:40:20.0194Z","caller":"traceutil/trace.go:171","msg":"trace[1006063173] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.420019595s","start":"2026-07-29T15:40:18.599374Z","end":"2026-07-29T15:40:20.019394Z","steps":["trace[1006063173] 'process raft request' (duration: 1.419599923s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:20.019436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.59935Z","time spent":"1.420070598s","remote":"127.0.0.1:58468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T15:40:20.019595Z","caller":"traceutil/trace.go:171","msg":"trace[1052601952] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:7; }","duration":"1.430725239s","start":"2026-07-29T15:40:18.588861Z","end":"2026-07-29T15:40:20.019586Z","steps":["trace[1052601952] 'read index received' (duration: 318.742404ms)","trace[1052601952] 'applied index is now lower than readState.Index' (duration: 1.111981535s)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:40:20.019623Z","caller":"traceutil/trace.go:171","msg":"trace[804940717] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.435788106s","start":"2026-07-29T15:40:18.583764Z","end":"2026-07-29T15:40:20.019552Z","steps":["trace[804940717] 'process raft request' (duration: 1.435124447s)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:40:20.019728Z","caller":"traceutil/trace.go:171","msg":"trace[577030787] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"800.409812ms","start":"2026-07-29T15:40:19.219314Z","end":"2026-07-29T15:40:20.019724Z","steps":["trace[577030787] 'process raft request' (duration: 799.709991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:20.019759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:19.219304Z","time spent":"800.439102ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T15:40:20.019882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.431014566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-29T15:40:20.019901Z","caller":"traceutil/trace.go:171","msg":"trace[565958544] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:13; }","duration":"1.431038107s","start":"2026-07-29T15:40:18.588857Z","end":"2026-07-29T15:40:20.019895Z","steps":["trace[565958544] 'agreement among raft nodes before linearized reading' (duration: 1.430976835s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:20.01992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.588837Z","time spent":"1.431076949s","remote":"127.0.0.1:58696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-07-29T15:40:20.019901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.58372Z","time spent":"1.436021323s","remote":"127.0.0.1:58814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T15:40:20.02002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.38523441s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-29T15:40:20.020037Z","caller":"traceutil/trace.go:171","msg":"trace[1125928652] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:13; }","duration":"1.38526689s","start":"2026-07-29T15:40:18.634766Z","end":"2026-07-29T15:40:20.020033Z","steps":["trace[1125928652] 'agreement among raft nodes before linearized reading' (duration: 1.385237409s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:20.020052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.634761Z","time spent":"1.385288161s","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-29T15:40:20.020219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.40206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-29T15:40:20.020195Z","caller":"traceutil/trace.go:171","msg":"trace[863502551] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.436301162s","start":"2026-07-29T15:40:18.583864Z","end":"2026-07-29T15:40:20.020166Z","steps":["trace[863502551] 'process raft request' (duration: 1.435049306s)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:40:20.020238Z","caller":"traceutil/trace.go:171","msg":"trace[857272462] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:13; }","duration":"538.453162ms","start":"2026-07-29T15:40:19.48178Z","end":"2026-07-29T15:40:20.020233Z","steps":["trace[857272462] 'agreement among raft nodes before linearized reading' (duration: 538.426031ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:20.020255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:19.481764Z","time spent":"538.487692ms","remote":"127.0.0.1:58676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-07-29T15:40:20.020211Z","caller":"traceutil/trace.go:171","msg":"trace[494464442] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.43624659s","start":"2026-07-29T15:40:18.58395Z","end":"2026-07-29T15:40:20.020197Z","steps":["trace[494464442] 'process raft request' (duration: 1.434980813s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:20.020287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.583849Z","time spent":"1.436399274s","remote":"127.0.0.1:58814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T15:40:20.020337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.535495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-29T15:40:20.020362Z","caller":"traceutil/trace.go:171","msg":"trace[805378198] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:13; }","duration":"538.563176ms","start":"2026-07-29T15:40:19.481794Z","end":"2026-07-29T15:40:20.020357Z","steps":["trace[805378198] 'agreement among raft nodes before linearized reading' (duration: 538.526595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:20.020351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.58394Z","time spent":"1.436344102s","remote":"127.0.0.1:58740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T15:40:20.02038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:19.481726Z","time spent":"538.649688ms","remote":"127.0.0.1:58656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-07-29T15:40:20.020464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.426029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-29T15:40:20.020479Z","caller":"traceutil/trace.go:171","msg":"trace[331311001] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13; }","duration":"803.473561ms","start":"2026-07-29T15:40:19.217001Z","end":"2026-07-29T15:40:20.020474Z","steps":["trace[331311001] 'agreement among raft nodes before linearized reading' (duration: 803.45033ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:40:20.019707Z","caller":"traceutil/trace.go:171","msg":"trace[1220960087] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"802.668147ms","start":"2026-07-29T15:40:19.217033Z","end":"2026-07-29T15:40:20.019701Z","steps":["trace[1220960087] 'process raft request' (duration: 801.976347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:20.020493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:19.216982Z","time spent":"803.508612ms","remote":"127.0.0.1:58292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-29T15:40:20.020514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:19.21701Z","time spent":"803.487252ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T15:40:20.020583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.261078611s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-29T15:40:20.020603Z","caller":"traceutil/trace.go:171","msg":"trace[714977320] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:13; }","duration":"1.261142432s","start":"2026-07-29T15:40:18.759453Z","end":"2026-07-29T15:40:20.020595Z","steps":["trace[714977320] 'agreement among raft nodes before linearized reading' (duration: 1.261116062s)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:40:20.020607Z","caller":"traceutil/trace.go:171","msg":"trace[825539838] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.43657128s","start":"2026-07-29T15:40:18.584029Z","end":"2026-07-29T15:40:20.0206Z","steps":["trace[825539838] 'process raft request' (duration: 1.434926662s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:20.020622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.759429Z","time spent":"1.261189655s","remote":"127.0.0.1:58542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-07-29T15:40:20.020644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:18.584009Z","time spent":"1.43661411s","remote":"127.0.0.1:58814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T15:40:22.003876Z","caller":"traceutil/trace.go:171","msg":"trace[2012094116] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"224.614494ms","start":"2026-07-29T15:40:21.779215Z","end":"2026-07-29T15:40:22.003829Z","steps":["trace[2012094116] 'process raft request' (duration: 214.623485ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:40:22.003825Z","caller":"traceutil/trace.go:171","msg":"trace[1575720678] linearizableReadLoop","detail":"{readStateIndex:258; appliedIndex:257; }","duration":"176.604889ms","start":"2026-07-29T15:40:21.827187Z","end":"2026-07-29T15:40:22.003792Z","steps":["trace[1575720678] 'read index received' (duration: 166.565638ms)","trace[1575720678] 'applied index is now lower than readState.Index' (duration: 10.037661ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:40:22.004131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.870047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-29T15:40:22.004292Z","caller":"traceutil/trace.go:171","msg":"trace[1057386464] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:252; }","duration":"177.159245ms","start":"2026-07-29T15:40:21.827108Z","end":"2026-07-29T15:40:22.004267Z","steps":["trace[1057386464] 'agreement among raft nodes before linearized reading' (duration: 176.784574ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:40:56.709991Z","caller":"traceutil/trace.go:171","msg":"trace[1281898750] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"112.387621ms","start":"2026-07-29T15:40:56.597521Z","end":"2026-07-29T15:40:56.709909Z","steps":["trace[1281898750] 'process raft request' (duration: 62.56289ms)","trace[1281898750] 'compare' (duration: 49.571104ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:40:56.710556Z","caller":"traceutil/trace.go:171","msg":"trace[1508705509] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"103.68452ms","start":"2026-07-29T15:40:56.606841Z","end":"2026-07-29T15:40:56.710525Z","steps":["trace[1508705509] 'process raft request' (duration: 103.109074ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:40:57.103183Z","caller":"traceutil/trace.go:171","msg":"trace[2117840616] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"353.406621ms","start":"2026-07-29T15:40:56.749751Z","end":"2026-07-29T15:40:57.103157Z","steps":["trace[2117840616] 'process raft request' (duration: 351.979832ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:57.103426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:56.749726Z","time spent":"353.512165ms","remote":"127.0.0.1:58334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T15:40:57.10762Z","caller":"traceutil/trace.go:171","msg":"trace[224219137] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"319.135891ms","start":"2026-07-29T15:40:56.788468Z","end":"2026-07-29T15:40:57.107604Z","steps":["trace[224219137] 'process raft request' (duration: 318.866733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:57.107683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:56.788434Z","time spent":"319.219783ms","remote":"127.0.0.1:58334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-29T15:40:57.107765Z","caller":"traceutil/trace.go:171","msg":"trace[324255581] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:589; }","duration":"109.224779ms","start":"2026-07-29T15:40:56.998511Z","end":"2026-07-29T15:40:57.107736Z","steps":["trace[324255581] 'read index received' (duration: 103.289266ms)","trace[324255581] 'applied index is now lower than readState.Index' (duration: 5.934383ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:40:57.107877Z","caller":"traceutil/trace.go:171","msg":"trace[659488473] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"312.878588ms","start":"2026-07-29T15:40:56.794992Z","end":"2026-07-29T15:40:57.107871Z","steps":["trace[659488473] 'process raft request' (duration: 312.57416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:57.107909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:40:56.794986Z","time spent":"312.905398ms","remote":"127.0.0.1:58334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T15:40:57.107965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.437794ms","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-29T15:40:57.108001Z","caller":"traceutil/trace.go:171","msg":"trace[1254113462] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"109.529857ms","start":"2026-07-29T15:40:56.998459Z","end":"2026-07-29T15:40:57.107989Z","steps":["trace[1254113462] 'agreement among raft nodes before linearized reading' (duration: 109.366183ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:41:02.594589Z","caller":"traceutil/trace.go:171","msg":"trace[1215014066] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"134.326647ms","start":"2026-07-29T15:41:02.460238Z","end":"2026-07-29T15:41:02.594564Z","steps":["trace[1215014066] 'process raft request' (duration: 133.797003ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:41:02.819783Z","caller":"traceutil/trace.go:171","msg":"trace[717460157] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"176.016085ms","start":"2026-07-29T15:41:02.64374Z","end":"2026-07-29T15:41:02.819757Z","steps":["trace[717460157] 'process raft request' (duration: 175.818401ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:41:02.828014Z","caller":"traceutil/trace.go:171","msg":"trace[1362460137] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"153.069229ms","start":"2026-07-29T15:41:02.674925Z","end":"2026-07-29T15:41:02.827994Z","steps":["trace[1362460137] 'process raft request' (duration: 152.978007ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:41:03.283675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.189407ms","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-07-29T15:41:03.283773Z","caller":"traceutil/trace.go:171","msg":"trace[744226352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"131.313411ms","start":"2026-07-29T15:41:03.152421Z","end":"2026-07-29T15:41:03.283735Z","steps":["trace[744226352] 'range keys from in-memory index tree' (duration: 131.037844ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:41:03.489003Z","caller":"traceutil/trace.go:171","msg":"trace[262882696] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"192.707645ms","start":"2026-07-29T15:41:03.296247Z","end":"2026-07-29T15:41:03.488955Z","steps":["trace[262882696] 'read index received' (duration: 182.97748ms)","trace[262882696] 'applied index is now lower than readState.Index' (duration: 9.729325ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:41:03.489268Z","caller":"traceutil/trace.go:171","msg":"trace[4634384] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"270.024644ms","start":"2026-07-29T15:41:03.218926Z","end":"2026-07-29T15:41:03.488951Z","steps":["trace[4634384] 'process raft request' (duration: 262.021355ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:41:03.489366Z","caller":"traceutil/trace.go:171","msg":"trace[1745221514] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"108.336205ms","start":"2026-07-29T15:41:03.380996Z","end":"2026-07-29T15:41:03.489332Z","steps":["trace[1745221514] 'process raft request' (duration: 107.932004ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:41:03.489485Z","caller":"traceutil/trace.go:171","msg":"trace[2070157330] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"200.712563ms","start":"2026-07-29T15:41:03.288745Z","end":"2026-07-29T15:41:03.489458Z","steps":["trace[2070157330] 'process raft request' (duration: 200.137837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:41:03.489624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.209092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-29T15:41:03.489665Z","caller":"traceutil/trace.go:171","msg":"trace[820948811] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"170.300044ms","start":"2026-07-29T15:41:03.319354Z","end":"2026-07-29T15:41:03.489654Z","steps":["trace[820948811] 'agreement among raft nodes before linearized reading' (duration: 170.153921ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:41:03.489645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.390993ms","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-29T15:41:03.489725Z","caller":"traceutil/trace.go:171","msg":"trace[37555588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"193.485166ms","start":"2026-07-29T15:41:03.296219Z","end":"2026-07-29T15:41:03.489704Z","steps":["trace[37555588] 'agreement among raft nodes before linearized reading' (duration: 193.215618ms)"],"step_count":1}