{"level":"warn","ts":"2026-05-08T10:23:10.49829Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T10:23:10.498365Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95: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.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95: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-05-08T10:23:10.498419Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T10:23:10.498433Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-05-08T10:23:10.498455Z","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-05-08T10:23:10.499497Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]} {"level":"info","ts":"2026-05-08T10:23:10.499608Z","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.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95: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-05-08T10:23:10.504547Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.375243ms"} {"level":"info","ts":"2026-05-08T10:23:10.516057Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"} {"level":"info","ts":"2026-05-08T10:23:10.516136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T10:23:10.516155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"} {"level":"info","ts":"2026-05-08T10:23:10.516165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T10:23:10.516172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"} {"level":"info","ts":"2026-05-08T10:23:10.516206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"warn","ts":"2026-05-08T10:23:10.526808Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T10:23:10.528471Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T10:23:10.530411Z","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-05-08T10:23:10.53351Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T10:23:10.53382Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T10:23:10.534205Z","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-05-08T10:23:10.534312Z","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-05-08T10:23:10.534326Z","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-05-08T10:23:10.534935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"info","ts":"2026-05-08T10:23:10.535142Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-05-08T10:23:10.555679Z","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-05-08T10:23:10.55594Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-05-08T10:23:10.556044Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-05-08T10:23:10.55602Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T10:23:10.556094Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T10:23:11.316734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T10:23:11.316825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T10:23:11.31685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"} {"level":"info","ts":"2026-05-08T10:23:11.316868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"} {"level":"info","ts":"2026-05-08T10:23:11.31688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-05-08T10:23:11.316892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"} {"level":"info","ts":"2026-05-08T10:23:11.316904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-05-08T10:23:11.318394Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:23:11.319417Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T10:23:11.319417Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T10:23:11.319496Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T10:23:11.319987Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:23:11.320105Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:23:11.320151Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:23:11.320522Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T10:23:11.320547Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T10:23:11.323066Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"} {"level":"info","ts":"2026-05-08T10:23:11.323254Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-08T10:23:14.191216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.246102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:23:14.191405Z","caller":"traceutil/trace.go:171","msg":"trace[1019913946] transaction","detail":"{read_only:false; response_revision:132; number_of_response:1; }","duration":"490.431544ms","start":"2026-05-08T10:23:13.700949Z","end":"2026-05-08T10:23:14.19138Z","steps":["trace[1019913946] 'process raft request' (duration: 84.356685ms)","trace[1019913946] 'compare' (duration: 405.076189ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:23:14.191583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:13.700888Z","time spent":"490.602668ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":582,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T10:23:14.328692Z","caller":"traceutil/trace.go:171","msg":"trace[75670615] transaction","detail":"{read_only:false; response_revision:133; number_of_response:1; }","duration":"131.497801ms","start":"2026-05-08T10:23:14.197164Z","end":"2026-05-08T10:23:14.328662Z","steps":["trace[75670615] 'process raft request' (duration: 106.807319ms)","trace[75670615] 'compare' (duration: 24.490178ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:41.063003Z","caller":"traceutil/trace.go:171","msg":"trace[1465192549] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"110.887633ms","start":"2026-05-08T10:23:40.95209Z","end":"2026-05-08T10:23:41.062978Z","steps":["trace[1465192549] 'process raft request' (duration: 109.998914ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:41.071393Z","caller":"traceutil/trace.go:171","msg":"trace[162452401] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"107.103704ms","start":"2026-05-08T10:23:40.964244Z","end":"2026-05-08T10:23:41.071348Z","steps":["trace[162452401] 'process raft request' (duration: 106.355058ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:41.071664Z","caller":"traceutil/trace.go:171","msg":"trace[507328433] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"107.225376ms","start":"2026-05-08T10:23:40.96439Z","end":"2026-05-08T10:23:41.071615Z","steps":["trace[507328433] 'process raft request' (duration: 106.827878ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:41.071712Z","caller":"traceutil/trace.go:171","msg":"trace[1694371535] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"100.492195ms","start":"2026-05-08T10:23:40.971195Z","end":"2026-05-08T10:23:41.071687Z","steps":["trace[1694371535] 'process raft request' (duration: 100.061156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:47.396035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.589021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:23:47.396141Z","caller":"traceutil/trace.go:171","msg":"trace[435310240] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"287.488372ms","start":"2026-05-08T10:23:47.108638Z","end":"2026-05-08T10:23:47.396127Z","steps":["trace[435310240] 'read index received' (duration: 13.453762ms)","trace[435310240] 'applied index is now lower than readState.Index' (duration: 274.03311ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:47.396199Z","caller":"traceutil/trace.go:171","msg":"trace[469790290] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"351.782469ms","start":"2026-05-08T10:23:47.044409Z","end":"2026-05-08T10:23:47.396191Z","steps":["trace[469790290] 'process raft request' (duration: 77.80806ms)","trace[469790290] 'compare' (duration: 273.383576ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:23:47.396241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:47.044375Z","time spent":"351.84542ms","remote":"127.0.0.1:34398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:23:47.396438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.812169ms","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-05-08T10:23:47.396455Z","caller":"traceutil/trace.go:171","msg":"trace[71289838] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:619; }","duration":"287.882941ms","start":"2026-05-08T10:23:47.108564Z","end":"2026-05-08T10:23:47.396447Z","steps":["trace[71289838] 'agreement among raft nodes before linearized reading' (duration: 287.789599ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:47.451006Z","caller":"traceutil/trace.go:171","msg":"trace[1045123877] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"143.769132ms","start":"2026-05-08T10:23:47.307203Z","end":"2026-05-08T10:23:47.450972Z","steps":["trace[1045123877] 'process raft request' (duration: 143.642699ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:47.451274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.753169ms","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-05-08T10:23:47.451364Z","caller":"traceutil/trace.go:171","msg":"trace[1095877095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"299.917242ms","start":"2026-05-08T10:23:47.151424Z","end":"2026-05-08T10:23:47.451341Z","steps":["trace[1095877095] 'agreement among raft nodes before linearized reading' (duration: 299.563684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:47.873111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.156317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:23:47.873978Z","caller":"traceutil/trace.go:171","msg":"trace[1169281702] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"472.759622ms","start":"2026-05-08T10:23:47.401167Z","end":"2026-05-08T10:23:47.873927Z","steps":["trace[1169281702] 'process raft request' (duration: 108.694657ms)","trace[1169281702] 'compare' (duration: 363.006623ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:23:47.874411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:47.401148Z","time spent":"473.181101ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:23:47.875816Z","caller":"traceutil/trace.go:171","msg":"trace[34349630] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"453.560931ms","start":"2026-05-08T10:23:47.422238Z","end":"2026-05-08T10:23:47.875799Z","steps":["trace[34349630] 'process raft request' (duration: 451.809605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:47.875913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:47.422198Z","time spent":"453.664713ms","remote":"127.0.0.1:34276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:23:47.954902Z","caller":"traceutil/trace.go:171","msg":"trace[1830497161] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"377.031967ms","start":"2026-05-08T10:23:47.577836Z","end":"2026-05-08T10:23:47.954868Z","steps":["trace[1830497161] 'read index received' (duration: 376.863754ms)","trace[1830497161] 'applied index is now lower than readState.Index' (duration: 166.953µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:47.954955Z","caller":"traceutil/trace.go:171","msg":"trace[2003405069] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"497.904789ms","start":"2026-05-08T10:23:47.457012Z","end":"2026-05-08T10:23:47.954917Z","steps":["trace[2003405069] 'process raft request' (duration: 497.643434ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:47.955157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:47.456977Z","time spent":"498.069403ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:23:47.955054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.20017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:23:47.95527Z","caller":"traceutil/trace.go:171","msg":"trace[1580136974] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"377.521277ms","start":"2026-05-08T10:23:47.577733Z","end":"2026-05-08T10:23:47.955254Z","steps":["trace[1580136974] 'agreement among raft nodes before linearized reading' (duration: 377.261702ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:47.955373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:47.57771Z","time spent":"377.624341ms","remote":"127.0.0.1:34174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T10:23:47.972428Z","caller":"traceutil/trace.go:171","msg":"trace[507275922] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"371.206256ms","start":"2026-05-08T10:23:47.6012Z","end":"2026-05-08T10:23:47.972406Z","steps":["trace[507275922] 'process raft request' (duration: 370.527991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:47.972556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:47.601166Z","time spent":"371.317669ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:23:49.279432Z","caller":"traceutil/trace.go:171","msg":"trace[993201620] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"116.465029ms","start":"2026-05-08T10:23:49.162928Z","end":"2026-05-08T10:23:49.279393Z","steps":["trace[993201620] 'process raft request' (duration: 116.325486ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:59.575563Z","caller":"traceutil/trace.go:171","msg":"trace[1176183113] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"236.152471ms","start":"2026-05-08T10:24:59.339381Z","end":"2026-05-08T10:24:59.575534Z","steps":["trace[1176183113] 'process raft request' (duration: 235.981197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:00.487645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.574146ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-08T10:25:00.487749Z","caller":"traceutil/trace.go:171","msg":"trace[856598370] linearizableReadLoop","detail":"{readStateIndex:1112; appliedIndex:1111; }","duration":"220.363429ms","start":"2026-05-08T10:25:00.267365Z","end":"2026-05-08T10:25:00.487729Z","steps":["trace[856598370] 'read index received' (duration: 32.18µs)","trace[856598370] 'applied index is now lower than readState.Index' (duration: 220.329539ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:25:00.48813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.754688ms","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-05-08T10:25:00.488174Z","caller":"traceutil/trace.go:171","msg":"trace[1830750286] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1069; }","duration":"220.854299ms","start":"2026-05-08T10:25:00.267308Z","end":"2026-05-08T10:25:00.488162Z","steps":["trace[1830750286] 'agreement among raft nodes before linearized reading' (duration: 220.602744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:00.488175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.579197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T10:25:00.488246Z","caller":"traceutil/trace.go:171","msg":"trace[1489953118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1069; }","duration":"190.690819ms","start":"2026-05-08T10:25:00.297537Z","end":"2026-05-08T10:25:00.488228Z","steps":["trace[1489953118] 'agreement among raft nodes before linearized reading' (duration: 190.474315ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:01.628045Z","caller":"traceutil/trace.go:171","msg":"trace[1041875054] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"199.661706ms","start":"2026-05-08T10:25:01.428344Z","end":"2026-05-08T10:25:01.628005Z","steps":["trace[1041875054] 'process raft request' (duration: 199.473512ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:29.643791Z","caller":"traceutil/trace.go:171","msg":"trace[2103678562] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"177.284098ms","start":"2026-05-08T10:25:29.466448Z","end":"2026-05-08T10:25:29.643732Z","steps":["trace[2103678562] 'process raft request' (duration: 177.128894ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:29.64384Z","caller":"traceutil/trace.go:171","msg":"trace[1181559187] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"179.340231ms","start":"2026-05-08T10:25:29.464462Z","end":"2026-05-08T10:25:29.643802Z","steps":["trace[1181559187] 'process raft request' (duration: 167.141056ms)","trace[1181559187] 'compare' (duration: 11.673544ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:25:33.947839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.385975ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:25:33.947982Z","caller":"traceutil/trace.go:171","msg":"trace[2037848158] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"170.53225ms","start":"2026-05-08T10:25:33.77742Z","end":"2026-05-08T10:25:33.947952Z","steps":["trace[2037848158] 'process raft request' (duration: 69.902609ms)","trace[2037848158] 'compare' (duration: 100.259743ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:25:34.88044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.866756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:25:34.880517Z","caller":"traceutil/trace.go:171","msg":"trace[630426886] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:0; response_revision:1283; }","duration":"112.979348ms","start":"2026-05-08T10:25:34.767522Z","end":"2026-05-08T10:25:34.880502Z","steps":["trace[630426886] 'range keys from in-memory index tree' (duration: 112.789744ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:35.009848Z","caller":"traceutil/trace.go:171","msg":"trace[1598603475] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1334; }","duration":"141.788871ms","start":"2026-05-08T10:25:34.868036Z","end":"2026-05-08T10:25:35.009825Z","steps":["trace[1598603475] 'read index received' (duration: 141.678988ms)","trace[1598603475] 'applied index is now lower than readState.Index' (duration: 108.703µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:25:35.009898Z","caller":"traceutil/trace.go:171","msg":"trace[140981139] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"141.866562ms","start":"2026-05-08T10:25:34.867989Z","end":"2026-05-08T10:25:35.009856Z","steps":["trace[140981139] 'process raft request' (duration: 141.702169ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:35.010534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.474285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-05-08T10:25:35.010615Z","caller":"traceutil/trace.go:171","msg":"trace[1825782776] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1284; }","duration":"142.569307ms","start":"2026-05-08T10:25:34.868029Z","end":"2026-05-08T10:25:35.010598Z","steps":["trace[1825782776] 'agreement among raft nodes before linearized reading' (duration: 141.917513ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:35.053821Z","caller":"traceutil/trace.go:171","msg":"trace[225910214] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"169.12332ms","start":"2026-05-08T10:25:34.884673Z","end":"2026-05-08T10:25:35.053796Z","steps":["trace[225910214] 'process raft request' (duration: 169.003268ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:35.185398Z","caller":"traceutil/trace.go:171","msg":"trace[2047032125] linearizableReadLoop","detail":"{readStateIndex:1339; appliedIndex:1338; }","duration":"111.924347ms","start":"2026-05-08T10:25:35.073445Z","end":"2026-05-08T10:25:35.18537Z","steps":["trace[2047032125] 'read index received' (duration: 111.753874ms)","trace[2047032125] 'applied index is now lower than readState.Index' (duration: 168.703µs)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:25:35.185694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.4689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-08T10:25:35.185781Z","caller":"traceutil/trace.go:171","msg":"trace[710622066] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1288; }","duration":"126.612463ms","start":"2026-05-08T10:25:35.059155Z","end":"2026-05-08T10:25:35.185767Z","steps":["trace[710622066] 'agreement among raft nodes before linearized reading' (duration: 126.308807ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:35.186118Z","caller":"traceutil/trace.go:171","msg":"trace[191195775] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"126.109023ms","start":"2026-05-08T10:25:35.059297Z","end":"2026-05-08T10:25:35.185406Z","steps":["trace[191195775] 'process raft request' (duration: 125.883068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:35.202138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.964861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.95\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-08T10:25:35.202218Z","caller":"traceutil/trace.go:171","msg":"trace[291343713] range","detail":"{range_begin:/registry/masterleases/199.204.45.95; range_end:; response_count:1; response_revision:1289; }","duration":"116.074033ms","start":"2026-05-08T10:25:35.086125Z","end":"2026-05-08T10:25:35.202199Z","steps":["trace[291343713] 'agreement among raft nodes before linearized reading' (duration: 115.91551ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:35.202248Z","caller":"traceutil/trace.go:171","msg":"trace[2050283713] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"124.756984ms","start":"2026-05-08T10:25:35.077471Z","end":"2026-05-08T10:25:35.202228Z","steps":["trace[2050283713] 'process raft request' (duration: 124.472658ms)"],"step_count":1}