{"level":"warn","ts":"2026-07-07T07:30:33.911413Z","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-07T07:30:33.911503Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.68: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.68:2380","--initial-cluster=instance=https://199.19.213.68:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.68:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.68: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-07T07:30:33.911571Z","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-07T07:30:33.911581Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.68:2380"]} {"level":"info","ts":"2026-07-07T07:30:33.911596Z","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-07T07:30:33.912315Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.68:2379"]} {"level":"info","ts":"2026-07-07T07:30:33.91242Z","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.68:2380"],"listen-peer-urls":["https://199.19.213.68:2380"],"advertise-client-urls":["https://199.19.213.68:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.68:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.68: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-07T07:30:33.914975Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.350492ms"} {"level":"info","ts":"2026-07-07T07:30:33.919009Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"78a0acde880f698","cluster-id":"45d27515d88ba308"} {"level":"info","ts":"2026-07-07T07:30:33.919104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 switched to configuration voters=()"} {"level":"info","ts":"2026-07-07T07:30:33.91913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 became follower at term 0"} {"level":"info","ts":"2026-07-07T07:30:33.919145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 78a0acde880f698 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-07T07:30:33.91916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 became follower at term 1"} {"level":"info","ts":"2026-07-07T07:30:33.919199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 switched to configuration voters=(543258584536905368)"} {"level":"warn","ts":"2026-07-07T07:30:33.923391Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-07T07:30:33.924509Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-07T07:30:33.925857Z","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-07T07:30:33.928287Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"78a0acde880f698","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-07T07:30:33.933842Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.68:2380"} {"level":"info","ts":"2026-07-07T07:30:33.933786Z","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-07T07:30:33.934026Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.68:2380"} {"level":"info","ts":"2026-07-07T07:30:33.934541Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"78a0acde880f698","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-07T07:30:33.934575Z","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-07T07:30:33.934713Z","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-07T07:30:33.934711Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"78a0acde880f698","initial-advertise-peer-urls":["https://199.19.213.68:2380"],"listen-peer-urls":["https://199.19.213.68:2380"],"advertise-client-urls":["https://199.19.213.68:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.68:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-07T07:30:33.934737Z","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-07T07:30:33.934749Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-07T07:30:33.935858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 switched to configuration voters=(543258584536905368)"} {"level":"info","ts":"2026-07-07T07:30:33.93599Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45d27515d88ba308","local-member-id":"78a0acde880f698","added-peer-id":"78a0acde880f698","added-peer-peer-urls":["https://199.19.213.68:2380"]} {"level":"info","ts":"2026-07-07T07:30:34.720061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 is starting a new election at term 1"} {"level":"info","ts":"2026-07-07T07:30:34.720122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-07T07:30:34.720196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 received MsgPreVoteResp from 78a0acde880f698 at term 1"} {"level":"info","ts":"2026-07-07T07:30:34.720223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 became candidate at term 2"} {"level":"info","ts":"2026-07-07T07:30:34.72024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 received MsgVoteResp from 78a0acde880f698 at term 2"} {"level":"info","ts":"2026-07-07T07:30:34.720261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"78a0acde880f698 became leader at term 2"} {"level":"info","ts":"2026-07-07T07:30:34.720279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 78a0acde880f698 elected leader 78a0acde880f698 at term 2"} {"level":"info","ts":"2026-07-07T07:30:34.721255Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-07T07:30:34.72199Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-07T07:30:34.722069Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-07T07:30:34.72198Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"78a0acde880f698","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.68:2379]}","request-path":"/0/members/78a0acde880f698/attributes","cluster-id":"45d27515d88ba308","publish-timeout":"7s"} {"level":"info","ts":"2026-07-07T07:30:34.7224Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-07T07:30:34.722461Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-07T07:30:34.72253Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45d27515d88ba308","local-member-id":"78a0acde880f698","cluster-version":"3.5"} {"level":"info","ts":"2026-07-07T07:30:34.722627Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-07T07:30:34.722657Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-07T07:30:34.72641Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.68:2379"} {"level":"info","ts":"2026-07-07T07:30:34.726409Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-07T07:30:52.373323Z","caller":"traceutil/trace.go:171","msg":"trace[755077837] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:424; }","duration":"241.463222ms","start":"2026-07-07T07:30:52.131835Z","end":"2026-07-07T07:30:52.373298Z","steps":["trace[755077837] 'read index received' (duration: 241.329259ms)","trace[755077837] 'applied index is now lower than readState.Index' (duration: 132.963µs)"],"step_count":2} {"level":"info","ts":"2026-07-07T07:30:52.373826Z","caller":"traceutil/trace.go:171","msg":"trace[608536178] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"304.584111ms","start":"2026-07-07T07:30:52.069208Z","end":"2026-07-07T07:30:52.373792Z","steps":["trace[608536178] 'process raft request' (duration: 303.865151ms)"],"step_count":1} {"level":"warn","ts":"2026-07-07T07:30:52.374265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.348116ms","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-07T07:30:52.374372Z","caller":"traceutil/trace.go:171","msg":"trace[2135288271] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:411; }","duration":"242.50008ms","start":"2026-07-07T07:30:52.131829Z","end":"2026-07-07T07:30:52.374329Z","steps":["trace[2135288271] 'agreement among raft nodes before linearized reading' (duration: 242.313615ms)"],"step_count":1} {"level":"warn","ts":"2026-07-07T07:30:52.374497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-07T07:30:52.069183Z","time spent":"304.750776ms","remote":"127.0.0.1:41256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5311,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-07T07:30:52.851122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.839992ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-07T07:30:52.85121Z","caller":"traceutil/trace.go:171","msg":"trace[1658541499] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"335.704334ms","start":"2026-07-07T07:30:52.515493Z","end":"2026-07-07T07:30:52.851197Z","steps":["trace[1658541499] 'read index received' (duration: 201.686507ms)","trace[1658541499] 'applied index is now lower than readState.Index' (duration: 134.015277ms)"],"step_count":2} {"level":"warn","ts":"2026-07-07T07:30:52.851261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.767346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-07T07:30:52.851278Z","caller":"traceutil/trace.go:171","msg":"trace[930816031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:414; }","duration":"335.818347ms","start":"2026-07-07T07:30:52.515453Z","end":"2026-07-07T07:30:52.851271Z","steps":["trace[930816031] 'agreement among raft nodes before linearized reading' (duration: 335.775755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-07T07:30:52.851303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-07T07:30:52.515432Z","time spent":"335.866758ms","remote":"127.0.0.1:41358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-07T07:30:52.851273Z","caller":"traceutil/trace.go:171","msg":"trace[2011666382] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"446.443247ms","start":"2026-07-07T07:30:52.404793Z","end":"2026-07-07T07:30:52.851236Z","steps":["trace[2011666382] 'process raft request' (duration: 312.324647ms)","trace[2011666382] 'compare' (duration: 133.73744ms)"],"step_count":2} {"level":"warn","ts":"2026-07-07T07:30:52.851599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-07T07:30:52.404776Z","time spent":"446.743985ms","remote":"127.0.0.1:41256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5139,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-07T07:31:18.975444Z","caller":"traceutil/trace.go:171","msg":"trace[856909383] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"178.218592ms","start":"2026-07-07T07:31:18.797201Z","end":"2026-07-07T07:31:18.97542Z","steps":["trace[856909383] 'process raft request' (duration: 177.705638ms)"],"step_count":1} {"level":"warn","ts":"2026-07-07T07:31:19.440164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.934489ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-07T07:31:19.440271Z","caller":"traceutil/trace.go:171","msg":"trace[653377955] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"392.15888ms","start":"2026-07-07T07:31:19.048093Z","end":"2026-07-07T07:31:19.440252Z","steps":["trace[653377955] 'process raft request' (duration: 136.070026ms)","trace[653377955] 'compare' (duration: 255.681823ms)"],"step_count":2} {"level":"warn","ts":"2026-07-07T07:31:19.440333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-07T07:31:19.04807Z","time spent":"392.236801ms","remote":"127.0.0.1:41284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-07T07:31:19.442303Z","caller":"traceutil/trace.go:171","msg":"trace[1273424645] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"125.763984ms","start":"2026-07-07T07:31:19.31652Z","end":"2026-07-07T07:31:19.442284Z","steps":["trace[1273424645] 'read index received' (duration: 125.548648ms)","trace[1273424645] 'applied index is now lower than readState.Index' (duration: 214.626µs)"],"step_count":2} {"level":"info","ts":"2026-07-07T07:31:19.442512Z","caller":"traceutil/trace.go:171","msg":"trace[1309715214] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"392.92869ms","start":"2026-07-07T07:31:19.049569Z","end":"2026-07-07T07:31:19.442498Z","steps":["trace[1309715214] 'process raft request' (duration: 392.56974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-07T07:31:19.442594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-07T07:31:19.049555Z","time spent":"392.996061ms","remote":"127.0.0.1:41358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-07T07:31:19.443046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.512295ms","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-07T07:31:19.443186Z","caller":"traceutil/trace.go:171","msg":"trace[660449737] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"126.69982ms","start":"2026-07-07T07:31:19.316475Z","end":"2026-07-07T07:31:19.443175Z","steps":["trace[660449737] 'agreement among raft nodes before linearized reading' (duration: 126.001211ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:31:19.658344Z","caller":"traceutil/trace.go:171","msg":"trace[695204552] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"208.692342ms","start":"2026-07-07T07:31:19.449628Z","end":"2026-07-07T07:31:19.65832Z","steps":["trace[695204552] 'read index received' (duration: 171.189001ms)","trace[695204552] 'applied index is now lower than readState.Index' (duration: 37.502081ms)"],"step_count":2} {"level":"warn","ts":"2026-07-07T07:31:19.658515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.859477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-07T07:31:19.658571Z","caller":"traceutil/trace.go:171","msg":"trace[534789668] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:629; }","duration":"208.97358ms","start":"2026-07-07T07:31:19.449573Z","end":"2026-07-07T07:31:19.658547Z","steps":["trace[534789668] 'agreement among raft nodes before linearized reading' (duration: 208.877678ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:31:19.658486Z","caller":"traceutil/trace.go:171","msg":"trace[1966058386] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"211.669014ms","start":"2026-07-07T07:31:19.446675Z","end":"2026-07-07T07:31:19.658344Z","steps":["trace[1966058386] 'process raft request' (duration: 174.107091ms)","trace[1966058386] 'compare' (duration: 37.299076ms)"],"step_count":2} {"level":"info","ts":"2026-07-07T07:32:35.98862Z","caller":"traceutil/trace.go:171","msg":"trace[90465574] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"164.354393ms","start":"2026-07-07T07:32:35.824237Z","end":"2026-07-07T07:32:35.988591Z","steps":["trace[90465574] 'process raft request' (duration: 164.182827ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:32:36.198716Z","caller":"traceutil/trace.go:171","msg":"trace[1641093562] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"206.150395ms","start":"2026-07-07T07:32:35.99253Z","end":"2026-07-07T07:32:36.198681Z","steps":["trace[1641093562] 'process raft request' (duration: 127.784811ms)","trace[1641093562] 'compare' (duration: 77.87094ms)"],"step_count":2} {"level":"info","ts":"2026-07-07T07:32:55.237948Z","caller":"traceutil/trace.go:171","msg":"trace[766937771] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"164.2298ms","start":"2026-07-07T07:32:55.073699Z","end":"2026-07-07T07:32:55.237929Z","steps":["trace[766937771] 'process raft request' (duration: 164.010294ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:32:55.237931Z","caller":"traceutil/trace.go:171","msg":"trace[1801189557] linearizableReadLoop","detail":"{readStateIndex:1261; appliedIndex:1260; }","duration":"132.408915ms","start":"2026-07-07T07:32:55.105481Z","end":"2026-07-07T07:32:55.23789Z","steps":["trace[1801189557] 'read index received' (duration: 132.193039ms)","trace[1801189557] 'applied index is now lower than readState.Index' (duration: 214.716µs)"],"step_count":2} {"level":"warn","ts":"2026-07-07T07:32:55.238139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.64763ms","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-07T07:32:55.238217Z","caller":"traceutil/trace.go:171","msg":"trace[862889411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1213; }","duration":"132.749363ms","start":"2026-07-07T07:32:55.105432Z","end":"2026-07-07T07:32:55.238181Z","steps":["trace[862889411] 'agreement among raft nodes before linearized reading' (duration: 132.562218ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:32:55.356193Z","caller":"traceutil/trace.go:171","msg":"trace[1446427539] linearizableReadLoop","detail":"{readStateIndex:1262; appliedIndex:1261; }","duration":"107.374223ms","start":"2026-07-07T07:32:55.248798Z","end":"2026-07-07T07:32:55.356172Z","steps":["trace[1446427539] 'read index received' (duration: 103.842808ms)","trace[1446427539] 'applied index is now lower than readState.Index' (duration: 3.530415ms)"],"step_count":2} {"level":"warn","ts":"2026-07-07T07:32:55.356455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.633589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-07T07:32:55.356534Z","caller":"traceutil/trace.go:171","msg":"trace[34957617] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1214; }","duration":"107.744172ms","start":"2026-07-07T07:32:55.248772Z","end":"2026-07-07T07:32:55.356516Z","steps":["trace[34957617] 'agreement among raft nodes before linearized reading' (duration: 107.522346ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:32:55.356586Z","caller":"traceutil/trace.go:171","msg":"trace[824197191] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"114.887674ms","start":"2026-07-07T07:32:55.241665Z","end":"2026-07-07T07:32:55.356553Z","steps":["trace[824197191] 'process raft request' (duration: 110.975039ms)"],"step_count":1} {"level":"warn","ts":"2026-07-07T07:33:11.194845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.221506ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-07T07:33:11.194935Z","caller":"traceutil/trace.go:171","msg":"trace[1118751641] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"283.311125ms","start":"2026-07-07T07:33:10.911609Z","end":"2026-07-07T07:33:11.19492Z","steps":["trace[1118751641] 'process raft request' (duration: 117.940245ms)","trace[1118751641] 'compare' (duration: 164.963259ms)"],"step_count":2} {"level":"info","ts":"2026-07-07T07:33:11.203291Z","caller":"traceutil/trace.go:171","msg":"trace[1542099527] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"285.954477ms","start":"2026-07-07T07:33:10.917321Z","end":"2026-07-07T07:33:11.203276Z","steps":["trace[1542099527] 'process raft request' (duration: 285.922986ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:33:11.203558Z","caller":"traceutil/trace.go:171","msg":"trace[656458099] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"291.850597ms","start":"2026-07-07T07:33:10.9117Z","end":"2026-07-07T07:33:11.203551Z","steps":["trace[656458099] 'process raft request' (duration: 291.458666ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:33:11.586984Z","caller":"traceutil/trace.go:171","msg":"trace[1414007600] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"107.855172ms","start":"2026-07-07T07:33:11.479106Z","end":"2026-07-07T07:33:11.586961Z","steps":["trace[1414007600] 'process raft request' (duration: 107.748769ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:33:11.600536Z","caller":"traceutil/trace.go:171","msg":"trace[786846647] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"118.286194ms","start":"2026-07-07T07:33:11.48223Z","end":"2026-07-07T07:33:11.600517Z","steps":["trace[786846647] 'process raft request' (duration: 118.151001ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:33:12.565467Z","caller":"traceutil/trace.go:171","msg":"trace[1342112069] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"366.231091ms","start":"2026-07-07T07:33:12.199217Z","end":"2026-07-07T07:33:12.565448Z","steps":["trace[1342112069] 'process raft request' (duration: 366.100728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-07T07:33:12.565606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-07T07:33:12.199192Z","time spent":"366.349666ms","remote":"127.0.0.1:41358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-07T07:33:12.570498Z","caller":"traceutil/trace.go:171","msg":"trace[1467537308] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1342; }","duration":"202.487875ms","start":"2026-07-07T07:33:12.367989Z","end":"2026-07-07T07:33:12.570477Z","steps":["trace[1467537308] 'read index received' (duration: 197.326386ms)","trace[1467537308] 'applied index is now lower than readState.Index' (duration: 5.160819ms)"],"step_count":2} {"level":"warn","ts":"2026-07-07T07:33:12.570691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.68638ms","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-07T07:33:12.570721Z","caller":"traceutil/trace.go:171","msg":"trace[155426445] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1293; }","duration":"202.765873ms","start":"2026-07-07T07:33:12.367945Z","end":"2026-07-07T07:33:12.570711Z","steps":["trace[155426445] 'agreement among raft nodes before linearized reading' (duration: 202.635709ms)"],"step_count":1} {"level":"info","ts":"2026-07-07T07:33:12.570924Z","caller":"traceutil/trace.go:171","msg":"trace[1505516861] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"227.542524ms","start":"2026-07-07T07:33:12.343373Z","end":"2026-07-07T07:33:12.570916Z","steps":["trace[1505516861] 'process raft request' (duration: 227.02762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-07T07:33:13.361836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.601275ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"}