{"level":"warn","ts":"2026-07-01T00:45:52.950101Z","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-01T00:45:52.950206Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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.204.45.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-01T00:45:52.95029Z","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-01T00:45:52.950306Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-07-01T00:45:52.95033Z","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-01T00:45:52.951154Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-07-01T00:45:52.95126Z","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.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-01T00:45:52.955172Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.640047ms"} {"level":"info","ts":"2026-07-01T00:45:52.962013Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-07-01T00:45:52.962123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T00:45:52.962157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-07-01T00:45:52.96222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T00:45:52.962281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-07-01T00:45:52.962409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-07-01T00:45:52.968664Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T00:45:52.972526Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T00:45:52.974134Z","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-01T00:45:52.976532Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T00:45:52.977049Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T00:45:52.977262Z","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-01T00:45:52.977294Z","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-01T00:45:52.977305Z","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-01T00:45:52.979937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-07-01T00:45:52.980215Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-07-01T00:45:52.981401Z","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-01T00:45:52.981523Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-07-01T00:45:52.981587Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-07-01T00:45:52.981819Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T00:45:52.981868Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T00:45:53.663067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T00:45:53.663161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T00:45:53.663186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-07-01T00:45:53.663243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-07-01T00:45:53.663265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-07-01T00:45:53.66329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-07-01T00:45:53.663367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-07-01T00:45:53.664607Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T00:45:53.664715Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T00:45:53.664826Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T00:45:53.664887Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T00:45:53.665233Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T00:45:53.66525Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T00:45:53.666021Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T00:45:53.666163Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T00:45:53.666346Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T00:45:53.666365Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T00:45:53.667714Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-07-01T00:45:55.258539Z","caller":"traceutil/trace.go:171","msg":"trace[1865120664] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"341.220144ms","start":"2026-07-01T00:45:54.917294Z","end":"2026-07-01T00:45:55.258514Z","steps":["trace[1865120664] 'read index received' (duration: 73.097746ms)","trace[1865120664] 'applied index is now lower than readState.Index' (duration: 268.121338ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:55.258567Z","caller":"traceutil/trace.go:171","msg":"trace[1452488206] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"345.722937ms","start":"2026-07-01T00:45:54.912806Z","end":"2026-07-01T00:45:55.258528Z","steps":["trace[1452488206] 'process raft request' (duration: 345.379905ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.258651Z","caller":"traceutil/trace.go:171","msg":"trace[92951728] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"282.690182ms","start":"2026-07-01T00:45:54.975955Z","end":"2026-07-01T00:45:55.258645Z","steps":["trace[92951728] 'process raft request' (duration: 282.43571ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.258691Z","caller":"traceutil/trace.go:171","msg":"trace[1961772163] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"282.632162ms","start":"2026-07-01T00:45:54.97605Z","end":"2026-07-01T00:45:55.258682Z","steps":["trace[1961772163] 'process raft request' (duration: 282.414541ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.258843Z","caller":"traceutil/trace.go:171","msg":"trace[612577257] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"282.741233ms","start":"2026-07-01T00:45:54.976081Z","end":"2026-07-01T00:45:55.258822Z","steps":["trace[612577257] 'process raft request' (duration: 282.407351ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.258651Z","caller":"traceutil/trace.go:171","msg":"trace[1499257647] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"282.655532ms","start":"2026-07-01T00:45:54.975986Z","end":"2026-07-01T00:45:55.258642Z","steps":["trace[1499257647] 'process raft request' (duration: 282.457831ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.258578Z","caller":"traceutil/trace.go:171","msg":"trace[1254000508] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"282.577391ms","start":"2026-07-01T00:45:54.975979Z","end":"2026-07-01T00:45:55.258556Z","steps":["trace[1254000508] 'process raft request' (duration: 282.43509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.259025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.667607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T00:45:55.259133Z","caller":"traceutil/trace.go:171","msg":"trace[1173048351] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:9; }","duration":"341.846078ms","start":"2026-07-01T00:45:54.917254Z","end":"2026-07-01T00:45:55.2591Z","steps":["trace[1173048351] 'agreement among raft nodes before linearized reading' (duration: 341.597626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.259199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:54.912786Z","time spent":"345.886338ms","remote":"127.0.0.1:46246","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-07-01T00:45:55.258625Z","caller":"traceutil/trace.go:171","msg":"trace[1237475197] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"282.713973ms","start":"2026-07-01T00:45:54.975903Z","end":"2026-07-01T00:45:55.258617Z","steps":["trace[1237475197] 'process raft request' (duration: 282.451971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.259172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:54.917164Z","time spent":"342.000319ms","remote":"127.0.0.1:46374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":27,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-07-01T00:45:55.403717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.872179ms","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-01T00:45:55.403737Z","caller":"traceutil/trace.go:171","msg":"trace[17418527] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"411.570253ms","start":"2026-07-01T00:45:54.992121Z","end":"2026-07-01T00:45:55.403691Z","steps":["trace[17418527] 'process raft request' (duration: 385.200123ms)","trace[17418527] 'compare' (duration: 26.026457ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:45:55.403802Z","caller":"traceutil/trace.go:171","msg":"trace[1004185771] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"428.002211ms","start":"2026-07-01T00:45:54.975779Z","end":"2026-07-01T00:45:55.403781Z","steps":["trace[1004185771] 'agreement among raft nodes before linearized reading' (duration: 427.78761ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.403851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.952673ms","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-01T00:45:55.403926Z","caller":"traceutil/trace.go:171","msg":"trace[1975835578] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"346.065524ms","start":"2026-07-01T00:45:55.05784Z","end":"2026-07-01T00:45:55.403906Z","steps":["trace[1975835578] 'agreement among raft nodes before linearized reading' (duration: 345.937163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.40391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:54.975765Z","time spent":"428.132212ms","remote":"127.0.0.1:46270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-07-01T00:45:55.404037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.536465ms","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-01T00:45:55.404069Z","caller":"traceutil/trace.go:171","msg":"trace[677958578] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"428.586525ms","start":"2026-07-01T00:45:54.975474Z","end":"2026-07-01T00:45:55.404061Z","steps":["trace[677958578] 'agreement among raft nodes before linearized reading' (duration: 428.542255ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.404095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:54.975464Z","time spent":"428.625465ms","remote":"127.0.0.1:46298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-01T00:45:55.403926Z","caller":"traceutil/trace.go:171","msg":"trace[356720257] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"408.50631ms","start":"2026-07-01T00:45:54.995365Z","end":"2026-07-01T00:45:55.403871Z","steps":["trace[356720257] 'process raft request' (duration: 408.124067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.403981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:55.057824Z","time spent":"346.148044ms","remote":"127.0.0.1:46298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-01T00:45:55.404309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:54.992107Z","time spent":"411.956135ms","remote":"127.0.0.1:46374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T00:45:55.404452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.83126ms","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-01T00:45:55.404499Z","caller":"traceutil/trace.go:171","msg":"trace[1210274494] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"434.8704ms","start":"2026-07-01T00:45:54.969612Z","end":"2026-07-01T00:45:55.404483Z","steps":["trace[1210274494] 'agreement among raft nodes before linearized reading' (duration: 434.81486ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.404581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:54.969588Z","time spent":"434.96655ms","remote":"127.0.0.1:46298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-01T00:45:55.40433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.657955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-01T00:45:55.404731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.197882ms","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-01T00:45:55.404728Z","caller":"traceutil/trace.go:171","msg":"trace[1044782337] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:0; response_revision:11; }","duration":"429.027698ms","start":"2026-07-01T00:45:54.975648Z","end":"2026-07-01T00:45:55.404676Z","steps":["trace[1044782337] 'agreement among raft nodes before linearized reading' (duration: 428.655646ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.4049Z","caller":"traceutil/trace.go:171","msg":"trace[666584044] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"435.332092ms","start":"2026-07-01T00:45:54.969516Z","end":"2026-07-01T00:45:55.404848Z","steps":["trace[666584044] 'agreement among raft nodes before linearized reading' (duration: 435.136571ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.404919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:54.975642Z","time spent":"429.23404ms","remote":"127.0.0.1:46212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.23\" "} {"level":"warn","ts":"2026-07-01T00:45:55.405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:54.969464Z","time spent":"435.485214ms","remote":"127.0.0.1:46298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-01T00:45:55.405259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.156783ms","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-01T00:45:55.405314Z","caller":"traceutil/trace.go:171","msg":"trace[1068474132] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"438.246683ms","start":"2026-07-01T00:45:54.967055Z","end":"2026-07-01T00:45:55.405302Z","steps":["trace[1068474132] 'agreement among raft nodes before linearized reading' (duration: 438.146513ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.405348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:54.967035Z","time spent":"438.306294ms","remote":"127.0.0.1:46298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-01T00:45:55.403552Z","caller":"traceutil/trace.go:171","msg":"trace[636841560] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:12; }","duration":"144.911135ms","start":"2026-07-01T00:45:55.258617Z","end":"2026-07-01T00:45:55.403528Z","steps":["trace[636841560] 'read index received' (duration: 118.774258ms)","trace[636841560] 'applied index is now lower than readState.Index' (duration: 26.135997ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:45:55.404308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:45:54.995352Z","time spent":"408.888643ms","remote":"127.0.0.1:46452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T00:45:55.411737Z","caller":"traceutil/trace.go:171","msg":"trace[1408902021] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"148.635823ms","start":"2026-07-01T00:45:55.263082Z","end":"2026-07-01T00:45:55.411718Z","steps":["trace[1408902021] 'process raft request' (duration: 148.472201ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.411775Z","caller":"traceutil/trace.go:171","msg":"trace[602479867] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"148.546132ms","start":"2026-07-01T00:45:55.263215Z","end":"2026-07-01T00:45:55.411761Z","steps":["trace[602479867] 'process raft request' (duration: 148.449581ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.411928Z","caller":"traceutil/trace.go:171","msg":"trace[849095293] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"148.694533ms","start":"2026-07-01T00:45:55.263191Z","end":"2026-07-01T00:45:55.411886Z","steps":["trace[849095293] 'process raft request' (duration: 148.447861ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.411785Z","caller":"traceutil/trace.go:171","msg":"trace[16467638] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"148.41753ms","start":"2026-07-01T00:45:55.263351Z","end":"2026-07-01T00:45:55.411768Z","steps":["trace[16467638] 'process raft request' (duration: 148.33716ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.411936Z","caller":"traceutil/trace.go:171","msg":"trace[325097361] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"147.943147ms","start":"2026-07-01T00:45:55.263971Z","end":"2026-07-01T00:45:55.411914Z","steps":["trace[325097361] 'process raft request' (duration: 147.768096ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:55.411823Z","caller":"traceutil/trace.go:171","msg":"trace[673917311] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"148.31618ms","start":"2026-07-01T00:45:55.263497Z","end":"2026-07-01T00:45:55.411813Z","steps":["trace[673917311] 'process raft request' (duration: 148.213129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:45:55.412004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.584724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T00:45:55.412259Z","caller":"traceutil/trace.go:171","msg":"trace[928375425] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:17; }","duration":"137.867096ms","start":"2026-07-01T00:45:55.274382Z","end":"2026-07-01T00:45:55.412249Z","steps":["trace[928375425] 'agreement among raft nodes before linearized reading' (duration: 137.547094ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:58.776662Z","caller":"traceutil/trace.go:171","msg":"trace[69514356] linearizableReadLoop","detail":"{readStateIndex:291; appliedIndex:290; }","duration":"110.894551ms","start":"2026-07-01T00:45:58.665727Z","end":"2026-07-01T00:45:58.776621Z","steps":["trace[69514356] 'read index received' (duration: 59.476348ms)","trace[69514356] 'applied index is now lower than readState.Index' (duration: 51.417013ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:45:58.776835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.097112ms","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-01T00:45:58.776921Z","caller":"traceutil/trace.go:171","msg":"trace[427434880] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:286; }","duration":"111.183313ms","start":"2026-07-01T00:45:58.665716Z","end":"2026-07-01T00:45:58.7769Z","steps":["trace[427434880] 'agreement among raft nodes before linearized reading' (duration: 111.037672ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:45:58.776959Z","caller":"traceutil/trace.go:171","msg":"trace[1875035667] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"123.920402ms","start":"2026-07-01T00:45:58.653018Z","end":"2026-07-01T00:45:58.776938Z","steps":["trace[1875035667] 'process raft request' (duration: 72.175227ms)","trace[1875035667] 'compare' (duration: 51.263922ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:45:58.789013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.052113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:45:58.789065Z","caller":"traceutil/trace.go:171","msg":"trace[1774070419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:293; }","duration":"114.139084ms","start":"2026-07-01T00:45:58.674914Z","end":"2026-07-01T00:45:58.789053Z","steps":["trace[1774070419] 'agreement among raft nodes before linearized reading' (duration: 114.045893ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:34.885021Z","caller":"traceutil/trace.go:171","msg":"trace[143612160] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"108.805962ms","start":"2026-07-01T00:46:34.776189Z","end":"2026-07-01T00:46:34.884995Z","steps":["trace[143612160] 'process raft request' (duration: 108.637728ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:34.919645Z","caller":"traceutil/trace.go:171","msg":"trace[1851383774] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"115.829731ms","start":"2026-07-01T00:46:34.803788Z","end":"2026-07-01T00:46:34.919618Z","steps":["trace[1851383774] 'process raft request' (duration: 115.702519ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:35.334345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.142408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-01T00:46:35.334367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.368609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-01T00:46:35.334447Z","caller":"traceutil/trace.go:171","msg":"trace[1118941908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"254.257721ms","start":"2026-07-01T00:46:35.080149Z","end":"2026-07-01T00:46:35.334406Z","steps":["trace[1118941908] 'range keys from in-memory index tree' (duration: 254.018476ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T00:46:35.334453Z","caller":"traceutil/trace.go:171","msg":"trace[1373069534] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"144.488662ms","start":"2026-07-01T00:46:35.189941Z","end":"2026-07-01T00:46:35.33443Z","steps":["trace[1373069534] 'range keys from in-memory index tree' (duration: 144.141204ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:35.334799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.762413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-01T00:46:35.33484Z","caller":"traceutil/trace.go:171","msg":"trace[1760856825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"312.847234ms","start":"2026-07-01T00:46:35.021981Z","end":"2026-07-01T00:46:35.334829Z","steps":["trace[1760856825] 'range keys from in-memory index tree' (duration: 311.815803ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:35.334892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:35.021952Z","time spent":"312.932116ms","remote":"127.0.0.1:46464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-01T00:46:35.883965Z","caller":"traceutil/trace.go:171","msg":"trace[1812343851] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"540.982394ms","start":"2026-07-01T00:46:35.34296Z","end":"2026-07-01T00:46:35.883942Z","steps":["trace[1812343851] 'process raft request' (duration: 492.682238ms)","trace[1812343851] 'compare' (duration: 47.831207ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T00:46:35.884142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:35.34295Z","time spent":"541.121727ms","remote":"127.0.0.1:46464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:46:35.88443Z","caller":"traceutil/trace.go:171","msg":"trace[1423217862] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"541.387073ms","start":"2026-07-01T00:46:35.343012Z","end":"2026-07-01T00:46:35.884399Z","steps":["trace[1423217862] 'process raft request' (duration: 540.845742ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:35.884722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:35.343006Z","time spent":"541.569546ms","remote":"127.0.0.1:46464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T00:46:35.8859Z","caller":"traceutil/trace.go:171","msg":"trace[105779804] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:653; }","duration":"162.916449ms","start":"2026-07-01T00:46:35.722968Z","end":"2026-07-01T00:46:35.885884Z","steps":["trace[105779804] 'read index received' (duration: 112.694423ms)","trace[105779804] 'applied index is now lower than readState.Index' (duration: 50.221256ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T00:46:35.885913Z","caller":"traceutil/trace.go:171","msg":"trace[852631441] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"535.789186ms","start":"2026-07-01T00:46:35.350113Z","end":"2026-07-01T00:46:35.885902Z","steps":["trace[852631441] 'process raft request' (duration: 535.257774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T00:46:35.886074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T00:46:35.350086Z","time spent":"535.925519ms","remote":"127.0.0.1:46286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T00:46:35.885972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.995471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T00:46:35.886278Z","caller":"traceutil/trace.go:171","msg":"trace[2123282723] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"163.339048ms","start":"2026-07-01T00:46:35.722928Z","end":"2026-07-01T00:46:35.886268Z","steps":["trace[2123282723] 'agreement among raft nodes before linearized reading' (duration: 163.010772ms)"],"step_count":1}