{"level":"warn","ts":"2026-06-23T18:45:52.69457Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T18:45:52.694652Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.62: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.62:2380","--initial-cluster=instance=https://199.19.213.62:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.62:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.62: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-06-23T18:45:52.694734Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T18:45:52.694748Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.62:2380"]} {"level":"info","ts":"2026-06-23T18:45:52.694784Z","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-06-23T18:45:52.696211Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.62:2379"]} {"level":"info","ts":"2026-06-23T18:45:52.69632Z","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.62:2380"],"listen-peer-urls":["https://199.19.213.62:2380"],"advertise-client-urls":["https://199.19.213.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.62: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-06-23T18:45:52.701554Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.961697ms"} {"level":"info","ts":"2026-06-23T18:45:52.72036Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2451868e402db19e","cluster-id":"1953d1daf63e3757"} {"level":"info","ts":"2026-06-23T18:45:52.720449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e switched to configuration voters=()"} {"level":"info","ts":"2026-06-23T18:45:52.720474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e became follower at term 0"} {"level":"info","ts":"2026-06-23T18:45:52.720491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2451868e402db19e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-23T18:45:52.720507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e became follower at term 1"} {"level":"info","ts":"2026-06-23T18:45:52.720541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e switched to configuration voters=(2617020803999183262)"} {"level":"warn","ts":"2026-06-23T18:45:52.730118Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-23T18:45:52.731793Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-23T18:45:52.733049Z","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-06-23T18:45:52.735924Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2451868e402db19e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-23T18:45:52.736317Z","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-06-23T18:45:52.736365Z","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-06-23T18:45:52.736376Z","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-06-23T18:45:52.736143Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2451868e402db19e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-23T18:45:52.737993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e switched to configuration voters=(2617020803999183262)"} {"level":"info","ts":"2026-06-23T18:45:52.738596Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1953d1daf63e3757","local-member-id":"2451868e402db19e","added-peer-id":"2451868e402db19e","added-peer-peer-urls":["https://199.19.213.62:2380"]} {"level":"info","ts":"2026-06-23T18:45:52.740426Z","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-06-23T18:45:52.740621Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.62:2380"} {"level":"info","ts":"2026-06-23T18:45:52.740699Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.62:2380"} {"level":"info","ts":"2026-06-23T18:45:52.740773Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2451868e402db19e","initial-advertise-peer-urls":["https://199.19.213.62:2380"],"listen-peer-urls":["https://199.19.213.62:2380"],"advertise-client-urls":["https://199.19.213.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-23T18:45:52.740807Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-23T18:45:53.621488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e is starting a new election at term 1"} {"level":"info","ts":"2026-06-23T18:45:53.621552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e became pre-candidate at term 1"} {"level":"info","ts":"2026-06-23T18:45:53.621591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e received MsgPreVoteResp from 2451868e402db19e at term 1"} {"level":"info","ts":"2026-06-23T18:45:53.621612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e became candidate at term 2"} {"level":"info","ts":"2026-06-23T18:45:53.621624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e received MsgVoteResp from 2451868e402db19e at term 2"} {"level":"info","ts":"2026-06-23T18:45:53.62164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2451868e402db19e became leader at term 2"} {"level":"info","ts":"2026-06-23T18:45:53.621655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2451868e402db19e elected leader 2451868e402db19e at term 2"} {"level":"info","ts":"2026-06-23T18:45:53.622469Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2451868e402db19e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.62:2379]}","request-path":"/0/members/2451868e402db19e/attributes","cluster-id":"1953d1daf63e3757","publish-timeout":"7s"} {"level":"info","ts":"2026-06-23T18:45:53.622721Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:45:53.623479Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T18:45:53.623887Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T18:45:53.625579Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1953d1daf63e3757","local-member-id":"2451868e402db19e","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:45:53.625693Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:45:53.625724Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:45:53.626228Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-23T18:45:53.626284Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-23T18:45:53.62748Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.62:2379"} {"level":"info","ts":"2026-06-23T18:45:53.628088Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-23T18:46:29.661235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.50998ms","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-06-23T18:46:29.661326Z","caller":"traceutil/trace.go:171","msg":"trace[74880441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:527; }","duration":"110.640493ms","start":"2026-06-23T18:46:29.550667Z","end":"2026-06-23T18:46:29.661308Z","steps":["trace[74880441] 'range keys from in-memory index tree' (duration: 110.361876ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.664833Z","caller":"traceutil/trace.go:171","msg":"trace[365956161] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"114.0568ms","start":"2026-06-23T18:46:29.550757Z","end":"2026-06-23T18:46:29.664814Z","steps":["trace[365956161] 'process raft request' (duration: 113.946537ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.843285Z","caller":"traceutil/trace.go:171","msg":"trace[2072762816] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"288.17106ms","start":"2026-06-23T18:46:29.555099Z","end":"2026-06-23T18:46:29.84327Z","steps":["trace[2072762816] 'process raft request' (duration: 288.018976ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.843541Z","caller":"traceutil/trace.go:171","msg":"trace[876990721] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"280.950586ms","start":"2026-06-23T18:46:29.562581Z","end":"2026-06-23T18:46:29.843532Z","steps":["trace[876990721] 'process raft request' (duration: 280.658578ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.843651Z","caller":"traceutil/trace.go:171","msg":"trace[1932735853] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"283.549189ms","start":"2026-06-23T18:46:29.560094Z","end":"2026-06-23T18:46:29.843643Z","steps":["trace[1932735853] 'process raft request' (duration: 283.079966ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.84382Z","caller":"traceutil/trace.go:171","msg":"trace[336765868] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"269.315868ms","start":"2026-06-23T18:46:29.574496Z","end":"2026-06-23T18:46:29.843812Z","steps":["trace[336765868] 'process raft request' (duration: 268.831004ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.843958Z","caller":"traceutil/trace.go:171","msg":"trace[2031952071] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"275.843142ms","start":"2026-06-23T18:46:29.568107Z","end":"2026-06-23T18:46:29.84395Z","steps":["trace[2031952071] 'process raft request' (duration: 275.191104ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.843975Z","caller":"traceutil/trace.go:171","msg":"trace[995074127] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"216.340907ms","start":"2026-06-23T18:46:29.627583Z","end":"2026-06-23T18:46:29.843924Z","steps":["trace[995074127] 'process raft request' (duration: 216.213884ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.844153Z","caller":"traceutil/trace.go:171","msg":"trace[2107486250] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"250.597361ms","start":"2026-06-23T18:46:29.593548Z","end":"2026-06-23T18:46:29.844145Z","steps":["trace[2107486250] 'process raft request' (duration: 249.927933ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.844261Z","caller":"traceutil/trace.go:171","msg":"trace[1798005439] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"265.643586ms","start":"2026-06-23T18:46:29.578611Z","end":"2026-06-23T18:46:29.844254Z","steps":["trace[1798005439] 'process raft request' (duration: 264.789631ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.844328Z","caller":"traceutil/trace.go:171","msg":"trace[1058285369] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"248.849963ms","start":"2026-06-23T18:46:29.595425Z","end":"2026-06-23T18:46:29.844275Z","steps":["trace[1058285369] 'process raft request' (duration: 248.209725ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.843238Z","caller":"traceutil/trace.go:171","msg":"trace[494326738] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"292.4636ms","start":"2026-06-23T18:46:29.550753Z","end":"2026-06-23T18:46:29.843216Z","steps":["trace[494326738] 'process raft request' (duration: 292.167852ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.855277Z","caller":"traceutil/trace.go:171","msg":"trace[15590577] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"130.456151ms","start":"2026-06-23T18:46:29.724809Z","end":"2026-06-23T18:46:29.855265Z","steps":["trace[15590577] 'process raft request' (duration: 130.41725ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.855582Z","caller":"traceutil/trace.go:171","msg":"trace[957781997] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"182.242369ms","start":"2026-06-23T18:46:29.67332Z","end":"2026-06-23T18:46:29.855562Z","steps":["trace[957781997] 'process raft request' (duration: 181.863118ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.855747Z","caller":"traceutil/trace.go:171","msg":"trace[849922907] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"185.563781ms","start":"2026-06-23T18:46:29.670168Z","end":"2026-06-23T18:46:29.855732Z","steps":["trace[849922907] 'process raft request' (duration: 184.992755ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:29.855469Z","caller":"traceutil/trace.go:171","msg":"trace[1557040217] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"186.973022ms","start":"2026-06-23T18:46:29.668483Z","end":"2026-06-23T18:46:29.855456Z","steps":["trace[1557040217] 'process raft request' (duration: 186.606641ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:30.345094Z","caller":"traceutil/trace.go:171","msg":"trace[868529592] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"224.61838ms","start":"2026-06-23T18:46:30.120447Z","end":"2026-06-23T18:46:30.345065Z","steps":["trace[868529592] 'process raft request' (duration: 224.402454ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:30.349757Z","caller":"traceutil/trace.go:171","msg":"trace[1019468026] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"220.887116ms","start":"2026-06-23T18:46:30.128853Z","end":"2026-06-23T18:46:30.34974Z","steps":["trace[1019468026] 'process raft request' (duration: 220.576427ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:30.349779Z","caller":"traceutil/trace.go:171","msg":"trace[1884023481] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"205.76844ms","start":"2026-06-23T18:46:30.143986Z","end":"2026-06-23T18:46:30.349755Z","steps":["trace[1884023481] 'process raft request' (duration: 205.617576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:36.002702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.36235ms","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-06-23T18:46:36.002908Z","caller":"traceutil/trace.go:171","msg":"trace[674976130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"118.556956ms","start":"2026-06-23T18:46:35.884249Z","end":"2026-06-23T18:46:36.002806Z","steps":["trace[674976130] 'range keys from in-memory index tree' (duration: 118.126494ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:36.362523Z","caller":"traceutil/trace.go:171","msg":"trace[1892763823] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"360.294649ms","start":"2026-06-23T18:46:36.002192Z","end":"2026-06-23T18:46:36.362486Z","steps":["trace[1892763823] 'read index received' (duration: 354.30316ms)","trace[1892763823] 'applied index is now lower than readState.Index' (duration: 5.990929ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:46:36.362588Z","caller":"traceutil/trace.go:171","msg":"trace[1552171553] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"448.422119ms","start":"2026-06-23T18:46:35.914142Z","end":"2026-06-23T18:46:36.362564Z","steps":["trace[1552171553] 'process raft request' (duration: 444.349725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:36.362687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.466304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:46:36.36277Z","caller":"traceutil/trace.go:171","msg":"trace[1479631752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"360.619368ms","start":"2026-06-23T18:46:36.002129Z","end":"2026-06-23T18:46:36.362749Z","steps":["trace[1479631752] 'agreement among raft nodes before linearized reading' (duration: 360.462734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:36.362811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:46:36.00211Z","time spent":"360.69332ms","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T18:46:36.363024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:46:35.914111Z","time spent":"448.547542ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036273,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:46:36.539672Z","caller":"traceutil/trace.go:171","msg":"trace[602039718] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"532.835315ms","start":"2026-06-23T18:46:36.006791Z","end":"2026-06-23T18:46:36.539626Z","steps":["trace[602039718] 'process raft request' (duration: 476.410737ms)","trace[602039718] 'compare' (duration: 56.022526ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:46:36.540059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:46:36.006774Z","time spent":"532.974528ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:46:36.540277Z","caller":"traceutil/trace.go:171","msg":"trace[2105649122] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"124.36337ms","start":"2026-06-23T18:46:36.415806Z","end":"2026-06-23T18:46:36.540169Z","steps":["trace[2105649122] 'process raft request' (duration: 123.583178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:37.505546Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12798841969587115403,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-23T18:46:37.81226Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.230419834s","expected-duration":"1s"} {"level":"info","ts":"2026-06-23T18:46:37.849973Z","caller":"traceutil/trace.go:171","msg":"trace[2026909048] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.268248679s","start":"2026-06-23T18:46:36.581696Z","end":"2026-06-23T18:46:37.849945Z","steps":["trace[2026909048] 'process raft request' (duration: 1.230772114s)","trace[2026909048] 'compare' (duration: 35.5312ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:46:37.850133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:46:36.581666Z","time spent":"1.268400183s","remote":"127.0.0.1:38152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:46:37.850583Z","caller":"traceutil/trace.go:171","msg":"trace[463430392] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:663; }","duration":"845.926685ms","start":"2026-06-23T18:46:37.004628Z","end":"2026-06-23T18:46:37.850554Z","steps":["trace[463430392] 'read index received' (duration: 807.921516ms)","trace[463430392] 'applied index is now lower than readState.Index' (duration: 38.004269ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:46:37.850658Z","caller":"traceutil/trace.go:171","msg":"trace[627580913] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"890.081787ms","start":"2026-06-23T18:46:36.960558Z","end":"2026-06-23T18:46:37.85064Z","steps":["trace[627580913] 'process raft request' (duration: 889.424209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:37.850727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.08584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T18:46:37.850749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:46:36.960532Z","time spent":"890.17502ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:46:37.850778Z","caller":"traceutil/trace.go:171","msg":"trace[2109025273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"846.189313ms","start":"2026-06-23T18:46:37.004574Z","end":"2026-06-23T18:46:37.850763Z","steps":["trace[2109025273] 'agreement among raft nodes before linearized reading' (duration: 846.10531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:37.85082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:46:37.004549Z","time spent":"846.260414ms","remote":"127.0.0.1:37950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T18:46:37.851022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.621784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-23T18:46:37.851067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.831948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-23T18:46:37.851105Z","caller":"traceutil/trace.go:171","msg":"trace[1565616985] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"385.90461ms","start":"2026-06-23T18:46:37.46519Z","end":"2026-06-23T18:46:37.851095Z","steps":["trace[1565616985] 'agreement among raft nodes before linearized reading' (duration: 385.771176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:37.851133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:46:37.465171Z","time spent":"385.956701ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T18:46:37.851121Z","caller":"traceutil/trace.go:171","msg":"trace[748354280] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"728.760398ms","start":"2026-06-23T18:46:37.12233Z","end":"2026-06-23T18:46:37.851091Z","steps":["trace[748354280] 'agreement among raft nodes before linearized reading' (duration: 728.512451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:37.85118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:46:37.12231Z","time spent":"728.856281ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-23T18:46:37.851366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.277333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-23T18:46:37.851394Z","caller":"traceutil/trace.go:171","msg":"trace[1417194217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"470.328535ms","start":"2026-06-23T18:46:37.381057Z","end":"2026-06-23T18:46:37.851385Z","steps":["trace[1417194217] 'agreement among raft nodes before linearized reading' (duration: 470.251823ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:37.851429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:46:37.381044Z","time spent":"470.379296ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-23T18:46:53.549085Z","caller":"traceutil/trace.go:171","msg":"trace[471735430] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"327.743174ms","start":"2026-06-23T18:46:53.221322Z","end":"2026-06-23T18:46:53.549066Z","steps":["trace[471735430] 'process raft request' (duration: 327.62285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:53.54922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:46:53.221307Z","time spent":"327.847316ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:47:27.008983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:47:26.548954Z","time spent":"460.024978ms","remote":"127.0.0.1:37980","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-23T18:47:27.008975Z","caller":"traceutil/trace.go:171","msg":"trace[861695876] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1050; }","duration":"296.144139ms","start":"2026-06-23T18:47:26.712809Z","end":"2026-06-23T18:47:27.008954Z","steps":["trace[861695876] 'read index received' (duration: 296.106087ms)","trace[861695876] 'applied index is now lower than readState.Index' (duration: 36.501µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:47:27.009126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.289142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:47:27.00918Z","caller":"traceutil/trace.go:171","msg":"trace[1382072162] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1011; }","duration":"296.419156ms","start":"2026-06-23T18:47:26.71275Z","end":"2026-06-23T18:47:27.009169Z","steps":["trace[1382072162] 'agreement among raft nodes before linearized reading' (duration: 296.281662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:27.493501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.319661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:47:27.493603Z","caller":"traceutil/trace.go:171","msg":"trace[1382339016] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1051; }","duration":"484.457576ms","start":"2026-06-23T18:47:27.009132Z","end":"2026-06-23T18:47:27.49359Z","steps":["trace[1382339016] 'read index received' (duration: 307.903739ms)","trace[1382339016] 'applied index is now lower than readState.Index' (duration: 176.552607ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:47:27.493925Z","caller":"traceutil/trace.go:171","msg":"trace[775141734] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"673.127065ms","start":"2026-06-23T18:47:26.820765Z","end":"2026-06-23T18:47:27.493892Z","steps":["trace[775141734] 'process raft request' (duration: 496.244349ms)","trace[775141734] 'compare' (duration: 176.166956ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:47:27.493872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.526245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-23T18:47:27.494102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:47:26.820736Z","time spent":"673.28774ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:47:27.494188Z","caller":"traceutil/trace.go:171","msg":"trace[348582385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1012; }","duration":"663.829504ms","start":"2026-06-23T18:47:26.830299Z","end":"2026-06-23T18:47:27.494128Z","steps":["trace[348582385] 'agreement among raft nodes before linearized reading' (duration: 663.417972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:27.49428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:47:26.83029Z","time spent":"663.951187ms","remote":"127.0.0.1:38222","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":"warn","ts":"2026-06-23T18:47:27.494197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.037602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:47:27.494446Z","caller":"traceutil/trace.go:171","msg":"trace[1666874102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1012; }","duration":"491.429164ms","start":"2026-06-23T18:47:27.002991Z","end":"2026-06-23T18:47:27.49442Z","steps":["trace[1666874102] 'agreement among raft nodes before linearized reading' (duration: 490.723034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:27.49454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:47:27.002969Z","time spent":"491.557157ms","remote":"127.0.0.1:37950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T18:47:27.496722Z","caller":"traceutil/trace.go:171","msg":"trace[300584267] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"460.863202ms","start":"2026-06-23T18:47:27.035829Z","end":"2026-06-23T18:47:27.496692Z","steps":["trace[300584267] 'process raft request' (duration: 460.81449ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:27.496871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:47:27.035815Z","time spent":"460.983185ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:47:27.497091Z","caller":"traceutil/trace.go:171","msg":"trace[1176705299] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"486.992139ms","start":"2026-06-23T18:47:27.010089Z","end":"2026-06-23T18:47:27.497081Z","steps":["trace[1176705299] 'process raft request' (duration: 486.431513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:27.49719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:47:27.010073Z","time spent":"487.0547ms","remote":"127.0.0.1:37980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:47:27.497631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.706494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:47:27.49768Z","caller":"traceutil/trace.go:171","msg":"trace[372811346] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1014; }","duration":"108.801607ms","start":"2026-06-23T18:47:27.388866Z","end":"2026-06-23T18:47:27.497667Z","steps":["trace[372811346] 'agreement among raft nodes before linearized reading' (duration: 108.725535ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:47:48.306486Z","caller":"traceutil/trace.go:171","msg":"trace[246732836] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"132.033452ms","start":"2026-06-23T18:47:48.174432Z","end":"2026-06-23T18:47:48.306466Z","steps":["trace[246732836] 'read index received' (duration: 131.908018ms)","trace[246732836] 'applied index is now lower than readState.Index' (duration: 124.384µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:47:48.306595Z","caller":"traceutil/trace.go:171","msg":"trace[934310944] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"150.77626ms","start":"2026-06-23T18:47:48.155811Z","end":"2026-06-23T18:47:48.306587Z","steps":["trace[934310944] 'process raft request' (duration: 150.518963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:48.306788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.342371ms","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-06-23T18:47:48.306817Z","caller":"traceutil/trace.go:171","msg":"trace[254954650] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1082; }","duration":"132.416803ms","start":"2026-06-23T18:47:48.174392Z","end":"2026-06-23T18:47:48.306808Z","steps":["trace[254954650] 'agreement among raft nodes before linearized reading' (duration: 132.30241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:48.30696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.129328ms","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-06-23T18:47:48.306987Z","caller":"traceutil/trace.go:171","msg":"trace[1965261381] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1082; }","duration":"119.17545ms","start":"2026-06-23T18:47:48.187802Z","end":"2026-06-23T18:47:48.306978Z","steps":["trace[1965261381] 'agreement among raft nodes before linearized reading' (duration: 119.096538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:48.307005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.691304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-23T18:47:48.307092Z","caller":"traceutil/trace.go:171","msg":"trace[1984729035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1082; }","duration":"130.792637ms","start":"2026-06-23T18:47:48.176279Z","end":"2026-06-23T18:47:48.307072Z","steps":["trace[1984729035] 'agreement among raft nodes before linearized reading' (duration: 130.55583ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:47:48.47202Z","caller":"traceutil/trace.go:171","msg":"trace[646573697] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"162.067279ms","start":"2026-06-23T18:47:48.309933Z","end":"2026-06-23T18:47:48.472Z","steps":["trace[646573697] 'process raft request' (duration: 161.922865ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:47:48.481065Z","caller":"traceutil/trace.go:171","msg":"trace[476378] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"170.157737ms","start":"2026-06-23T18:47:48.31088Z","end":"2026-06-23T18:47:48.481038Z","steps":["trace[476378] 'process raft request' (duration: 170.112795ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:47:48.48109Z","caller":"traceutil/trace.go:171","msg":"trace[1622308805] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"171.083893ms","start":"2026-06-23T18:47:48.30997Z","end":"2026-06-23T18:47:48.481054Z","steps":["trace[1622308805] 'process raft request' (duration: 170.891468ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:47:49.875631Z","caller":"traceutil/trace.go:171","msg":"trace[1380640023] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"157.970913ms","start":"2026-06-23T18:47:49.717626Z","end":"2026-06-23T18:47:49.875597Z","steps":["trace[1380640023] 'process raft request' (duration: 88.186186ms)","trace[1380640023] 'compare' (duration: 69.583852ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:47:50.936381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.147389ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:47:50.936756Z","caller":"traceutil/trace.go:171","msg":"trace[555115228] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"433.828719ms","start":"2026-06-23T18:47:50.502903Z","end":"2026-06-23T18:47:50.936732Z","steps":["trace[555115228] 'process raft request' (duration: 433.739727ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:47:50.936752Z","caller":"traceutil/trace.go:171","msg":"trace[1691093261] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"433.954243ms","start":"2026-06-23T18:47:50.502763Z","end":"2026-06-23T18:47:50.936718Z","steps":["trace[1691093261] 'process raft request' (duration: 121.101944ms)","trace[1691093261] 'compare' (duration: 311.930553ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:47:50.936849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:47:50.502877Z","time spent":"433.922062ms","remote":"127.0.0.1:38222","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-06-23T18:47:50.936917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:47:50.502751Z","time spent":"434.070936ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:48:06.662938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.184209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.62\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-23T18:48:06.663026Z","caller":"traceutil/trace.go:171","msg":"trace[182833352] range","detail":"{range_begin:/registry/masterleases/199.19.213.62; range_end:; response_count:1; response_revision:1191; }","duration":"114.315772ms","start":"2026-06-23T18:48:06.548685Z","end":"2026-06-23T18:48:06.663001Z","steps":["trace[182833352] 'range keys from in-memory index tree' (duration: 113.954893ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:48:06.818935Z","caller":"traceutil/trace.go:171","msg":"trace[20132434] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"152.679424ms","start":"2026-06-23T18:48:06.66623Z","end":"2026-06-23T18:48:06.81891Z","steps":["trace[20132434] 'process raft request' (duration: 152.574791ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:48:21.964791Z","caller":"traceutil/trace.go:171","msg":"trace[1503782604] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"301.330839ms","start":"2026-06-23T18:48:21.663418Z","end":"2026-06-23T18:48:21.964749Z","steps":["trace[1503782604] 'process raft request' (duration: 299.920639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:21.964998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:48:21.663395Z","time spent":"301.507514ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":797,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:48:21.98648Z","caller":"traceutil/trace.go:171","msg":"trace[2084275572] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"174.840443ms","start":"2026-06-23T18:48:21.811604Z","end":"2026-06-23T18:48:21.986444Z","steps":["trace[2084275572] 'process raft request' (duration: 174.596577ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:48:26.166574Z","caller":"traceutil/trace.go:171","msg":"trace[910849646] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"167.886729ms","start":"2026-06-23T18:48:25.998661Z","end":"2026-06-23T18:48:26.166548Z","steps":["trace[910849646] 'process raft request' (duration: 167.755615ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:48:26.167259Z","caller":"traceutil/trace.go:171","msg":"trace[430756131] linearizableReadLoop","detail":"{readStateIndex:1342; appliedIndex:1342; }","duration":"164.562397ms","start":"2026-06-23T18:48:26.002685Z","end":"2026-06-23T18:48:26.167247Z","steps":["trace[430756131] 'read index received' (duration: 164.558547ms)","trace[430756131] 'applied index is now lower than readState.Index' (duration: 2.93µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:48:26.167568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.363032ms","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-06-23T18:48:26.167629Z","caller":"traceutil/trace.go:171","msg":"trace[435729282] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1289; }","duration":"121.461985ms","start":"2026-06-23T18:48:26.046156Z","end":"2026-06-23T18:48:26.167618Z","steps":["trace[435729282] 'agreement among raft nodes before linearized reading' (duration: 121.260519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:26.167683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.471695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-23T18:48:26.167775Z","caller":"traceutil/trace.go:171","msg":"trace[740481480] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1289; }","duration":"117.595908ms","start":"2026-06-23T18:48:26.050161Z","end":"2026-06-23T18:48:26.167757Z","steps":["trace[740481480] 'agreement among raft nodes before linearized reading' (duration: 117.31333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:26.167918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.659149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:48:26.167976Z","caller":"traceutil/trace.go:171","msg":"trace[217948127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1289; }","duration":"165.293057ms","start":"2026-06-23T18:48:26.002659Z","end":"2026-06-23T18:48:26.167952Z","steps":["trace[217948127] 'agreement among raft nodes before linearized reading' (duration: 164.66254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:27.170902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.523957ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:48:27.17102Z","caller":"traceutil/trace.go:171","msg":"trace[7661621] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1346; }","duration":"274.394919ms","start":"2026-06-23T18:48:26.896605Z","end":"2026-06-23T18:48:27.171Z","steps":["trace[7661621] 'read index received' (duration: 27.341µs)","trace[7661621] 'applied index is now lower than readState.Index' (duration: 274.366328ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:48:27.171113Z","caller":"traceutil/trace.go:171","msg":"trace[122371073] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"604.19107ms","start":"2026-06-23T18:48:26.56691Z","end":"2026-06-23T18:48:27.171101Z","steps":["trace[122371073] 'process raft request' (duration: 87.311213ms)","trace[122371073] 'compare' (duration: 516.412244ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:48:27.171194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:48:26.566887Z","time spent":"604.252381ms","remote":"127.0.0.1:37980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:48:27.171473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.862531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-23T18:48:27.171539Z","caller":"traceutil/trace.go:171","msg":"trace[1907724856] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1293; }","duration":"274.949204ms","start":"2026-06-23T18:48:26.89657Z","end":"2026-06-23T18:48:27.171519Z","steps":["trace[1907724856] 'agreement among raft nodes before linearized reading' (duration: 274.751579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:27.474649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.309383ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:48:27.474913Z","caller":"traceutil/trace.go:171","msg":"trace[1787145984] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1347; }","duration":"298.262864ms","start":"2026-06-23T18:48:27.17663Z","end":"2026-06-23T18:48:27.474893Z","steps":["trace[1787145984] 'read index received' (duration: 153.805037ms)","trace[1787145984] 'applied index is now lower than readState.Index' (duration: 144.456427ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:48:27.475039Z","caller":"traceutil/trace.go:171","msg":"trace[1990979594] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"299.656992ms","start":"2026-06-23T18:48:27.175362Z","end":"2026-06-23T18:48:27.475019Z","steps":["trace[1990979594] 'process raft request' (duration: 154.841536ms)","trace[1990979594] 'compare' (duration: 143.805228ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:48:27.475144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.48402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-23T18:48:27.475254Z","caller":"traceutil/trace.go:171","msg":"trace[943702768] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1296; }","duration":"298.618033ms","start":"2026-06-23T18:48:27.176615Z","end":"2026-06-23T18:48:27.475233Z","steps":["trace[943702768] 'agreement among raft nodes before linearized reading' (duration: 298.448118ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:48:27.475487Z","caller":"traceutil/trace.go:171","msg":"trace[449064242] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"299.59006ms","start":"2026-06-23T18:48:27.175884Z","end":"2026-06-23T18:48:27.475474Z","steps":["trace[449064242] 'process raft request' (duration: 298.898751ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:48:27.475594Z","caller":"traceutil/trace.go:171","msg":"trace[647697661] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"299.503398ms","start":"2026-06-23T18:48:27.176081Z","end":"2026-06-23T18:48:27.475584Z","steps":["trace[647697661] 'process raft request' (duration: 298.764037ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:48:35.941971Z","caller":"traceutil/trace.go:171","msg":"trace[333873892] linearizableReadLoop","detail":"{readStateIndex:1408; appliedIndex:1407; }","duration":"436.591539ms","start":"2026-06-23T18:48:35.505352Z","end":"2026-06-23T18:48:35.941943Z","steps":["trace[333873892] 'read index received' (duration: 436.25898ms)","trace[333873892] 'applied index is now lower than readState.Index' (duration: 331.459µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:48:35.942119Z","caller":"traceutil/trace.go:171","msg":"trace[1508601977] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"687.930514ms","start":"2026-06-23T18:48:35.25414Z","end":"2026-06-23T18:48:35.942071Z","steps":["trace[1508601977] 'process raft request' (duration: 687.569874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:35.942235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.098668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-23T18:48:35.942306Z","caller":"traceutil/trace.go:171","msg":"trace[1752347613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1353; }","duration":"435.229381ms","start":"2026-06-23T18:48:35.507065Z","end":"2026-06-23T18:48:35.942295Z","steps":["trace[1752347613] 'agreement among raft nodes before linearized reading' (duration: 435.039526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:35.942341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:48:35.507046Z","time spent":"435.286932ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T18:48:35.942335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.97051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-23T18:48:35.942365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:48:35.254123Z","time spent":"688.099139ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:48:35.942363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.676165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-23T18:48:35.942402Z","caller":"traceutil/trace.go:171","msg":"trace[954585596] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1353; }","duration":"437.075463ms","start":"2026-06-23T18:48:35.505309Z","end":"2026-06-23T18:48:35.942385Z","steps":["trace[954585596] 'agreement among raft nodes before linearized reading' (duration: 436.792405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:35.942466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:48:35.505294Z","time spent":"437.156204ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-23T18:48:35.942464Z","caller":"traceutil/trace.go:171","msg":"trace[1190691802] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1353; }","duration":"434.793229ms","start":"2026-06-23T18:48:35.507644Z","end":"2026-06-23T18:48:35.942437Z","steps":["trace[1190691802] 'agreement among raft nodes before linearized reading' (duration: 434.532762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:35.942527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:48:35.507638Z","time spent":"434.877671ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T18:48:36.285615Z","caller":"traceutil/trace.go:171","msg":"trace[1531931146] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"337.705533ms","start":"2026-06-23T18:48:35.947891Z","end":"2026-06-23T18:48:36.285597Z","steps":["trace[1531931146] 'process raft request' (duration: 337.62243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:36.28575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:48:35.947875Z","time spent":"337.821485ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:48:36.28576Z","caller":"traceutil/trace.go:171","msg":"trace[562698037] linearizableReadLoop","detail":"{readStateIndex:1411; appliedIndex:1408; }","duration":"283.331857ms","start":"2026-06-23T18:48:36.002407Z","end":"2026-06-23T18:48:36.285739Z","steps":["trace[562698037] 'read index received' (duration: 231.467582ms)","trace[562698037] 'applied index is now lower than readState.Index' (duration: 51.863255ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:48:36.28587Z","caller":"traceutil/trace.go:171","msg":"trace[1466651806] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"339.250915ms","start":"2026-06-23T18:48:35.946612Z","end":"2026-06-23T18:48:36.285863Z","steps":["trace[1466651806] 'process raft request' (duration: 287.246956ms)","trace[1466651806] 'compare' (duration: 51.493045ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:48:36.2859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:48:35.946596Z","time spent":"339.286506ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:48:36.285934Z","caller":"traceutil/trace.go:171","msg":"trace[1520565781] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"337.991371ms","start":"2026-06-23T18:48:35.947931Z","end":"2026-06-23T18:48:36.285922Z","steps":["trace[1520565781] 'process raft request' (duration: 337.644111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:36.285994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.858633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:48:36.286015Z","caller":"traceutil/trace.go:171","msg":"trace[513619941] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1357; }","duration":"193.911635ms","start":"2026-06-23T18:48:36.092096Z","end":"2026-06-23T18:48:36.286008Z","steps":["trace[513619941] 'agreement among raft nodes before linearized reading' (duration: 193.856413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:48:36.286031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:48:35.947914Z","time spent":"338.046652ms","remote":"127.0.0.1:38222","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-06-23T18:48:36.286056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.636756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T18:48:36.286112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.635009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:48:36.28613Z","caller":"traceutil/trace.go:171","msg":"trace[283862921] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1357; }","duration":"145.723761ms","start":"2026-06-23T18:48:36.140401Z","end":"2026-06-23T18:48:36.286125Z","steps":["trace[283862921] 'agreement among raft nodes before linearized reading' (duration: 145.69503ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:48:36.286136Z","caller":"traceutil/trace.go:171","msg":"trace[1923444907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1357; }","duration":"283.755109ms","start":"2026-06-23T18:48:36.002363Z","end":"2026-06-23T18:48:36.286118Z","steps":["trace[1923444907] 'agreement among raft nodes before linearized reading' (duration: 283.599565ms)"],"step_count":1}