{"level":"warn","ts":"2026-06-22T01:52:51.103773Z","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-22T01:52:51.10388Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-22T01:52:51.10396Z","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-22T01:52:51.103972Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-06-22T01:52:51.103994Z","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-22T01:52:51.104619Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-06-22T01:52:51.10469Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-22T01:52:51.107616Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.714946ms"} {"level":"info","ts":"2026-06-22T01:52:51.111615Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-06-22T01:52:51.112242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-06-22T01:52:51.112279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-06-22T01:52:51.112294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-22T01:52:51.112308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-06-22T01:52:51.112359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-06-22T01:52:51.117494Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-22T01:52:51.118664Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-22T01:52:51.119781Z","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-22T01:52:51.121911Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-22T01:52:51.122054Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-22T01:52:51.123452Z","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-22T01:52:51.124036Z","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-22T01:52:51.124052Z","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-22T01:52:51.136011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-06-22T01:52:51.136336Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-06-22T01:52:51.138118Z","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-22T01:52:51.13821Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-06-22T01:52:51.138276Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-06-22T01:52:51.138488Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-22T01:52:51.13855Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-22T01:52:51.41361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-06-22T01:52:51.413688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-22T01:52:51.413747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-06-22T01:52:51.413916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-06-22T01:52:51.414013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-06-22T01:52:51.414108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-06-22T01:52:51.414186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-06-22T01:52:51.415274Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:52:51.416526Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-06-22T01:52:51.41675Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T01:52:51.416793Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T01:52:51.417117Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:52:51.417365Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:52:51.417434Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:52:51.418292Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-22T01:52:51.418374Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-22T01:52:51.419127Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-06-22T01:52:51.419845Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-22T01:53:07.596788Z","caller":"traceutil/trace.go:171","msg":"trace[1943551357] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"102.523021ms","start":"2026-06-22T01:53:07.494238Z","end":"2026-06-22T01:53:07.596761Z","steps":["trace[1943551357] 'process raft request' (duration: 102.374556ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:25.268239Z","caller":"traceutil/trace.go:171","msg":"trace[1166318387] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"115.206157ms","start":"2026-06-22T01:53:25.153Z","end":"2026-06-22T01:53:25.268207Z","steps":["trace[1166318387] 'process raft request' (duration: 23.749541ms)","trace[1166318387] 'compare' (duration: 91.348353ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:53:28.761131Z","caller":"traceutil/trace.go:171","msg":"trace[847806995] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"133.750318ms","start":"2026-06-22T01:53:28.627352Z","end":"2026-06-22T01:53:28.761102Z","steps":["trace[847806995] 'process raft request' (duration: 133.535762ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:28.761259Z","caller":"traceutil/trace.go:171","msg":"trace[288495406] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"130.369197ms","start":"2026-06-22T01:53:28.630838Z","end":"2026-06-22T01:53:28.761207Z","steps":["trace[288495406] 'process raft request' (duration: 130.150051ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:28.761256Z","caller":"traceutil/trace.go:171","msg":"trace[462189788] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"130.329416ms","start":"2026-06-22T01:53:28.630896Z","end":"2026-06-22T01:53:28.761225Z","steps":["trace[462189788] 'process raft request' (duration: 130.184543ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:28.761142Z","caller":"traceutil/trace.go:171","msg":"trace[268043318] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:568; }","duration":"125.457665ms","start":"2026-06-22T01:53:28.635664Z","end":"2026-06-22T01:53:28.761122Z","steps":["trace[268043318] 'read index received' (duration: 125.319651ms)","trace[268043318] 'applied index is now lower than readState.Index' (duration: 137.144µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:53:28.761608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.919207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-06-22T01:53:28.7617Z","caller":"traceutil/trace.go:171","msg":"trace[324139749] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:544; }","duration":"126.04466ms","start":"2026-06-22T01:53:28.635643Z","end":"2026-06-22T01:53:28.761687Z","steps":["trace[324139749] 'agreement among raft nodes before linearized reading' (duration: 125.722941ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:28.767025Z","caller":"traceutil/trace.go:171","msg":"trace[1334348481] transaction","detail":"{read_only:false; number_of_response:0; response_revision:544; }","duration":"131.356893ms","start":"2026-06-22T01:53:28.635658Z","end":"2026-06-22T01:53:28.767014Z","steps":["trace[1334348481] 'process raft request' (duration: 131.192688ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:28.767154Z","caller":"traceutil/trace.go:171","msg":"trace[672561387] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"131.408854ms","start":"2026-06-22T01:53:28.635721Z","end":"2026-06-22T01:53:28.76713Z","steps":["trace[672561387] 'process raft request' (duration: 131.189598ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:28.767521Z","caller":"traceutil/trace.go:171","msg":"trace[191531783] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"116.397379ms","start":"2026-06-22T01:53:28.651111Z","end":"2026-06-22T01:53:28.767509Z","steps":["trace[191531783] 'process raft request' (duration: 115.865035ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:28.770503Z","caller":"traceutil/trace.go:171","msg":"trace[1770425681] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"114.780766ms","start":"2026-06-22T01:53:28.655657Z","end":"2026-06-22T01:53:28.770438Z","steps":["trace[1770425681] 'process raft request' (duration: 111.377954ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:28.77585Z","caller":"traceutil/trace.go:171","msg":"trace[1533837321] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"116.190714ms","start":"2026-06-22T01:53:28.659628Z","end":"2026-06-22T01:53:28.775818Z","steps":["trace[1533837321] 'process raft request' (duration: 108.831476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:28.777095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.040499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10078"} {"level":"info","ts":"2026-06-22T01:53:28.777127Z","caller":"traceutil/trace.go:171","msg":"trace[1341580843] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:549; }","duration":"126.105521ms","start":"2026-06-22T01:53:28.651013Z","end":"2026-06-22T01:53:28.777118Z","steps":["trace[1341580843] 'agreement among raft nodes before linearized reading' (duration: 124.972101ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:28.777168Z","caller":"traceutil/trace.go:171","msg":"trace[1759303427] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"101.645441ms","start":"2026-06-22T01:53:28.674348Z","end":"2026-06-22T01:53:28.775993Z","steps":["trace[1759303427] 'process raft request' (duration: 101.353463ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:34.869006Z","caller":"traceutil/trace.go:171","msg":"trace[1103974022] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"181.101056ms","start":"2026-06-22T01:53:34.687861Z","end":"2026-06-22T01:53:34.868962Z","steps":["trace[1103974022] 'read index received' (duration: 178.017083ms)","trace[1103974022] 'applied index is now lower than readState.Index' (duration: 3.082373ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:53:34.86935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.457585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-22T01:53:34.869422Z","caller":"traceutil/trace.go:171","msg":"trace[1219089585] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:621; }","duration":"181.60805ms","start":"2026-06-22T01:53:34.687795Z","end":"2026-06-22T01:53:34.869403Z","steps":["trace[1219089585] 'agreement among raft nodes before linearized reading' (duration: 181.423815ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:34.869085Z","caller":"traceutil/trace.go:171","msg":"trace[1650462594] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"182.106053ms","start":"2026-06-22T01:53:34.686939Z","end":"2026-06-22T01:53:34.869045Z","steps":["trace[1650462594] 'process raft request' (duration: 179.857452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:36.01478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.51648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-22T01:53:36.014915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.572687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mqzn4\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-22T01:53:36.015038Z","caller":"traceutil/trace.go:171","msg":"trace[863417695] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mqzn4; range_end:; response_count:1; response_revision:624; }","duration":"661.742482ms","start":"2026-06-22T01:53:35.353261Z","end":"2026-06-22T01:53:36.015003Z","steps":["trace[863417695] 'range keys from in-memory index tree' (duration: 661.276519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:36.01509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:53:35.353242Z","time spent":"661.837084ms","remote":"127.0.0.1:38910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-mqzn4\" "} {"level":"info","ts":"2026-06-22T01:53:36.014878Z","caller":"traceutil/trace.go:171","msg":"trace[1806389308] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"706.647114ms","start":"2026-06-22T01:53:35.308206Z","end":"2026-06-22T01:53:36.014853Z","steps":["trace[1806389308] 'range keys from in-memory index tree' (duration: 706.336555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:36.015377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:53:35.308189Z","time spent":"707.172037ms","remote":"127.0.0.1:38994","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-22T01:53:36.109813Z","caller":"traceutil/trace.go:171","msg":"trace[513680154] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"480.604774ms","start":"2026-06-22T01:53:35.629164Z","end":"2026-06-22T01:53:36.109769Z","steps":["trace[513680154] 'read index received' (duration: 479.610037ms)","trace[513680154] 'applied index is now lower than readState.Index' (duration: 993.677µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:53:36.109862Z","caller":"traceutil/trace.go:171","msg":"trace[1241529238] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"670.876877ms","start":"2026-06-22T01:53:35.438944Z","end":"2026-06-22T01:53:36.109821Z","steps":["trace[1241529238] 'process raft request' (duration: 670.209279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:36.110001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.81031ms","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-22T01:53:36.110073Z","caller":"traceutil/trace.go:171","msg":"trace[750572300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"480.912573ms","start":"2026-06-22T01:53:35.62912Z","end":"2026-06-22T01:53:36.110033Z","steps":["trace[750572300] 'agreement among raft nodes before linearized reading' (duration: 480.80254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:36.110117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:53:35.629101Z","time spent":"481.007085ms","remote":"127.0.0.1:38994","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":"warn","ts":"2026-06-22T01:53:36.110596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:53:35.438914Z","time spent":"671.015761ms","remote":"127.0.0.1:38798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036157,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:53:36.176657Z","caller":"traceutil/trace.go:171","msg":"trace[1973471591] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"156.568544ms","start":"2026-06-22T01:53:36.020068Z","end":"2026-06-22T01:53:36.176636Z","steps":["trace[1973471591] 'process raft request' (duration: 152.752181ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:36.177044Z","caller":"traceutil/trace.go:171","msg":"trace[1555754923] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"148.822585ms","start":"2026-06-22T01:53:36.028213Z","end":"2026-06-22T01:53:36.177035Z","steps":["trace[1555754923] 'process raft request' (duration: 148.368643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:36.177361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.670781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:53:36.177399Z","caller":"traceutil/trace.go:171","msg":"trace[1685344390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"214.762754ms","start":"2026-06-22T01:53:35.962627Z","end":"2026-06-22T01:53:36.17739Z","steps":["trace[1685344390] 'agreement among raft nodes before linearized reading' (duration: 214.677281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:36.177831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.577078ms","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-22T01:53:36.17787Z","caller":"traceutil/trace.go:171","msg":"trace[1473504253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"548.64889ms","start":"2026-06-22T01:53:35.629212Z","end":"2026-06-22T01:53:36.177861Z","steps":["trace[1473504253] 'agreement among raft nodes before linearized reading' (duration: 547.943411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:36.177895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:53:35.629189Z","time spent":"548.698422ms","remote":"127.0.0.1:38994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-22T01:54:25.40219Z","caller":"traceutil/trace.go:171","msg":"trace[2110011174] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"116.840676ms","start":"2026-06-22T01:54:25.28532Z","end":"2026-06-22T01:54:25.40216Z","steps":["trace[2110011174] 'process raft request' (duration: 116.687452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:25.58951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.756144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-22T01:54:25.589622Z","caller":"traceutil/trace.go:171","msg":"trace[1741783484] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1011; }","duration":"116.898558ms","start":"2026-06-22T01:54:25.472696Z","end":"2026-06-22T01:54:25.589594Z","steps":["trace[1741783484] 'range keys from in-memory index tree' (duration: 116.546038ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:46.689923Z","caller":"traceutil/trace.go:171","msg":"trace[1276756519] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"126.832977ms","start":"2026-06-22T01:54:46.563064Z","end":"2026-06-22T01:54:46.689897Z","steps":["trace[1276756519] 'process raft request' (duration: 126.680743ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:46.711994Z","caller":"traceutil/trace.go:171","msg":"trace[1155411137] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1127; }","duration":"135.47382ms","start":"2026-06-22T01:54:46.576493Z","end":"2026-06-22T01:54:46.711967Z","steps":["trace[1155411137] 'read index received' (duration: 113.26413ms)","trace[1155411137] 'applied index is now lower than readState.Index' (duration: 22.20871ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:54:46.712126Z","caller":"traceutil/trace.go:171","msg":"trace[2068014631] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"148.113061ms","start":"2026-06-22T01:54:46.563969Z","end":"2026-06-22T01:54:46.712082Z","steps":["trace[2068014631] 'process raft request' (duration: 147.836894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:46.712174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.672295ms","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-22T01:54:46.71221Z","caller":"traceutil/trace.go:171","msg":"trace[1211401973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1082; }","duration":"135.746237ms","start":"2026-06-22T01:54:46.576453Z","end":"2026-06-22T01:54:46.7122Z","steps":["trace[1211401973] 'agreement among raft nodes before linearized reading' (duration: 135.605554ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:48.009658Z","caller":"traceutil/trace.go:171","msg":"trace[1067777863] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1130; }","duration":"112.53588ms","start":"2026-06-22T01:54:47.897069Z","end":"2026-06-22T01:54:48.009605Z","steps":["trace[1067777863] 'read index received' (duration: 112.436618ms)","trace[1067777863] 'applied index is now lower than readState.Index' (duration: 98.412µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:54:48.009664Z","caller":"traceutil/trace.go:171","msg":"trace[536942800] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"305.416301ms","start":"2026-06-22T01:54:47.704218Z","end":"2026-06-22T01:54:48.009634Z","steps":["trace[536942800] 'process raft request' (duration: 305.254257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.009821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.735875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-22T01:54:48.009836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:54:47.704208Z","time spent":"305.547964ms","remote":"127.0.0.1:38994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:54:48.009875Z","caller":"traceutil/trace.go:171","msg":"trace[843736703] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1084; }","duration":"112.832268ms","start":"2026-06-22T01:54:47.89703Z","end":"2026-06-22T01:54:48.009862Z","steps":["trace[843736703] 'agreement among raft nodes before linearized reading' (duration: 112.676514ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.510416Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125955553064235345,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-22T01:54:48.585858Z","caller":"traceutil/trace.go:171","msg":"trace[955689136] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"583.888954ms","start":"2026-06-22T01:54:48.001947Z","end":"2026-06-22T01:54:48.585836Z","steps":["trace[955689136] 'process raft request' (duration: 583.73377ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.586001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:54:48.001926Z","time spent":"584.005397ms","remote":"127.0.0.1:38994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:54:48.597449Z","caller":"traceutil/trace.go:171","msg":"trace[179116997] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"584.593052ms","start":"2026-06-22T01:54:48.012836Z","end":"2026-06-22T01:54:48.597429Z","steps":["trace[179116997] 'process raft request' (duration: 584.347406ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.597589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:54:48.012822Z","time spent":"584.693446ms","remote":"127.0.0.1:38994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T01:54:48.597606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.622408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:54:48.597679Z","caller":"traceutil/trace.go:171","msg":"trace[1540433188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1086; }","duration":"636.736692ms","start":"2026-06-22T01:54:47.960924Z","end":"2026-06-22T01:54:48.597661Z","steps":["trace[1540433188] 'agreement among raft nodes before linearized reading' (duration: 636.589008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.597725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:54:47.960901Z","time spent":"636.810104ms","remote":"127.0.0.1:38720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-22T01:54:48.597355Z","caller":"traceutil/trace.go:171","msg":"trace[623035121] linearizableReadLoop","detail":"{readStateIndex:1133; appliedIndex:1131; }","duration":"587.607305ms","start":"2026-06-22T01:54:48.009719Z","end":"2026-06-22T01:54:48.597327Z","steps":["trace[623035121] 'read index received' (duration: 575.94475ms)","trace[623035121] 'applied index is now lower than readState.Index' (duration: 11.661525ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:54:48.841332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.758522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-22T01:54:48.84135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.972083ms","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-22T01:54:48.8414Z","caller":"traceutil/trace.go:171","msg":"trace[1471333731] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1086; }","duration":"147.871185ms","start":"2026-06-22T01:54:48.693515Z","end":"2026-06-22T01:54:48.841387Z","steps":["trace[1471333731] 'range keys from in-memory index tree' (duration: 147.614668ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:48.84146Z","caller":"traceutil/trace.go:171","msg":"trace[465210232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1086; }","duration":"126.091247ms","start":"2026-06-22T01:54:48.715321Z","end":"2026-06-22T01:54:48.841412Z","steps":["trace[465210232] 'range keys from in-memory index tree' (duration: 125.821959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.841621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.651556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-22T01:54:48.841642Z","caller":"traceutil/trace.go:171","msg":"trace[826943225] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1086; }","duration":"138.694987ms","start":"2026-06-22T01:54:48.702941Z","end":"2026-06-22T01:54:48.841636Z","steps":["trace[826943225] 'count revisions from in-memory index tree' (duration: 138.610955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.841385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.08828ms","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-22T01:54:48.841678Z","caller":"traceutil/trace.go:171","msg":"trace[1055821179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1086; }","duration":"108.381788ms","start":"2026-06-22T01:54:48.73329Z","end":"2026-06-22T01:54:48.841672Z","steps":["trace[1055821179] 'range keys from in-memory index tree' (duration: 108.027369ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:49.014532Z","caller":"traceutil/trace.go:171","msg":"trace[494810366] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"168.643806ms","start":"2026-06-22T01:54:48.845866Z","end":"2026-06-22T01:54:49.01451Z","steps":["trace[494810366] 'process raft request' (duration: 168.584194ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:49.01457Z","caller":"traceutil/trace.go:171","msg":"trace[736609909] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"110.30354ms","start":"2026-06-22T01:54:48.904244Z","end":"2026-06-22T01:54:49.014548Z","steps":["trace[736609909] 'process raft request' (duration: 110.232138ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:49.014663Z","caller":"traceutil/trace.go:171","msg":"trace[1647382535] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"168.879042ms","start":"2026-06-22T01:54:48.845759Z","end":"2026-06-22T01:54:49.014638Z","steps":["trace[1647382535] 'process raft request' (duration: 142.752837ms)","trace[1647382535] 'compare' (duration: 25.834668ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:55:04.904207Z","caller":"traceutil/trace.go:171","msg":"trace[222009365] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1239; }","duration":"241.609308ms","start":"2026-06-22T01:55:04.662574Z","end":"2026-06-22T01:55:04.904183Z","steps":["trace[222009365] 'read index received' (duration: 241.360901ms)","trace[222009365] 'applied index is now lower than readState.Index' (duration: 247.396µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:55:04.904276Z","caller":"traceutil/trace.go:171","msg":"trace[1874769199] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"267.399484ms","start":"2026-06-22T01:55:04.636847Z","end":"2026-06-22T01:55:04.904247Z","steps":["trace[1874769199] 'process raft request' (duration: 267.183318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:04.904462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.856684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-22T01:55:04.904534Z","caller":"traceutil/trace.go:171","msg":"trace[2132115791] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1188; }","duration":"241.957127ms","start":"2026-06-22T01:55:04.662563Z","end":"2026-06-22T01:55:04.90452Z","steps":["trace[2132115791] 'agreement among raft nodes before linearized reading' (duration: 241.72498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:04.904528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.900578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-22T01:55:04.904578Z","caller":"traceutil/trace.go:171","msg":"trace[712538443] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:1188; }","duration":"213.96381ms","start":"2026-06-22T01:55:04.690603Z","end":"2026-06-22T01:55:04.904567Z","steps":["trace[712538443] 'agreement among raft nodes before linearized reading' (duration: 213.784755ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:05.098533Z","caller":"traceutil/trace.go:171","msg":"trace[537632952] linearizableReadLoop","detail":"{readStateIndex:1242; appliedIndex:1240; }","duration":"136.528048ms","start":"2026-06-22T01:55:04.961972Z","end":"2026-06-22T01:55:05.0985Z","steps":["trace[537632952] 'read index received' (duration: 117.949746ms)","trace[537632952] 'applied index is now lower than readState.Index' (duration: 18.577182ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:55:05.098665Z","caller":"traceutil/trace.go:171","msg":"trace[48218263] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"190.074935ms","start":"2026-06-22T01:55:04.908579Z","end":"2026-06-22T01:55:05.098654Z","steps":["trace[48218263] 'process raft request' (duration: 189.734656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:05.098851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.863117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:55:05.098929Z","caller":"traceutil/trace.go:171","msg":"trace[132011799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1189; }","duration":"136.98676ms","start":"2026-06-22T01:55:04.961931Z","end":"2026-06-22T01:55:05.098918Z","steps":["trace[132011799] 'agreement among raft nodes before linearized reading' (duration: 136.876047ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:23.184322Z","caller":"traceutil/trace.go:171","msg":"trace[1230981697] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"184.175295ms","start":"2026-06-22T01:55:23.000105Z","end":"2026-06-22T01:55:23.18428Z","steps":["trace[1230981697] 'process raft request' (duration: 183.931179ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:23.984171Z","caller":"traceutil/trace.go:171","msg":"trace[1472666802] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"233.475228ms","start":"2026-06-22T01:55:23.750671Z","end":"2026-06-22T01:55:23.984146Z","steps":["trace[1472666802] 'process raft request' (duration: 233.347124ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:24.462173Z","caller":"traceutil/trace.go:171","msg":"trace[1443158141] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"137.35621ms","start":"2026-06-22T01:55:24.324798Z","end":"2026-06-22T01:55:24.462154Z","steps":["trace[1443158141] 'process raft request' (duration: 137.244147ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:25.024933Z","caller":"traceutil/trace.go:171","msg":"trace[389114524] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"176.299493ms","start":"2026-06-22T01:55:24.848602Z","end":"2026-06-22T01:55:25.024901Z","steps":["trace[389114524] 'process raft request' (duration: 166.583259ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:34.623386Z","caller":"traceutil/trace.go:171","msg":"trace[1550694358] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"120.117244ms","start":"2026-06-22T01:55:34.503243Z","end":"2026-06-22T01:55:34.62336Z","steps":["trace[1550694358] 'process raft request' (duration: 119.965929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:34.963113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.248216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-22T01:55:34.963187Z","caller":"traceutil/trace.go:171","msg":"trace[1607864491] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:1350; }","duration":"270.355369ms","start":"2026-06-22T01:55:34.692816Z","end":"2026-06-22T01:55:34.963171Z","steps":["trace[1607864491] 'range keys from in-memory index tree' (duration: 270.118552ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:35.259353Z","caller":"traceutil/trace.go:171","msg":"trace[220424112] linearizableReadLoop","detail":"{readStateIndex:1409; appliedIndex:1408; }","duration":"150.353288ms","start":"2026-06-22T01:55:35.108968Z","end":"2026-06-22T01:55:35.259322Z","steps":["trace[220424112] 'read index received' (duration: 150.05217ms)","trace[220424112] 'applied index is now lower than readState.Index' (duration: 299.078µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:55:35.25994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.958664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-22T01:55:35.260035Z","caller":"traceutil/trace.go:171","msg":"trace[351942717] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1350; }","duration":"151.098879ms","start":"2026-06-22T01:55:35.108914Z","end":"2026-06-22T01:55:35.260013Z","steps":["trace[351942717] 'agreement among raft nodes before linearized reading' (duration: 150.507112ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:35.384505Z","caller":"traceutil/trace.go:171","msg":"trace[1410246828] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"158.033907ms","start":"2026-06-22T01:55:35.226446Z","end":"2026-06-22T01:55:35.38448Z","steps":["trace[1410246828] 'process raft request' (duration: 153.717289ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:35.385547Z","caller":"traceutil/trace.go:171","msg":"trace[648798056] linearizableReadLoop","detail":"{readStateIndex:1412; appliedIndex:1409; }","duration":"113.187844ms","start":"2026-06-22T01:55:35.272345Z","end":"2026-06-22T01:55:35.385533Z","steps":["trace[648798056] 'read index received' (duration: 107.807157ms)","trace[648798056] 'applied index is now lower than readState.Index' (duration: 5.379587ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:55:35.385634Z","caller":"traceutil/trace.go:171","msg":"trace[1145996687] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"125.313185ms","start":"2026-06-22T01:55:35.260312Z","end":"2026-06-22T01:55:35.385626Z","steps":["trace[1145996687] 'process raft request' (duration: 125.095379ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:35.386272Z","caller":"traceutil/trace.go:171","msg":"trace[1711093020] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"120.633478ms","start":"2026-06-22T01:55:35.265615Z","end":"2026-06-22T01:55:35.386248Z","steps":["trace[1711093020] 'process raft request' (duration: 119.879567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:35.386563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.201032ms","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-22T01:55:35.386622Z","caller":"traceutil/trace.go:171","msg":"trace[955156993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1353; }","duration":"114.296785ms","start":"2026-06-22T01:55:35.272311Z","end":"2026-06-22T01:55:35.386608Z","steps":["trace[955156993] 'agreement among raft nodes before linearized reading' (duration: 113.980066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:35.387722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.310021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-06-22T01:55:35.387795Z","caller":"traceutil/trace.go:171","msg":"trace[851010722] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1353; }","duration":"108.416585ms","start":"2026-06-22T01:55:35.279366Z","end":"2026-06-22T01:55:35.387782Z","steps":["trace[851010722] 'agreement among raft nodes before linearized reading' (duration: 106.608035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:57:37.445177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.222255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-22T01:57:37.445252Z","caller":"traceutil/trace.go:171","msg":"trace[1394328917] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1913; }","duration":"269.343398ms","start":"2026-06-22T01:57:37.175895Z","end":"2026-06-22T01:57:37.445239Z","steps":["trace[1394328917] 'range keys from in-memory index tree' (duration: 269.091582ms)"],"step_count":1}