{"level":"warn","ts":"2026-02-20T15:59:24.985577Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-20T15:59:24.985749Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246: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.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246: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-02-20T15:59:24.98589Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-20T15:59:24.985922Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]}
{"level":"info","ts":"2026-02-20T15:59:24.985949Z","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-02-20T15:59:24.986972Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]}
{"level":"info","ts":"2026-02-20T15:59:24.987101Z","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.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246: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-02-20T15:59:24.995369Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.823749ms"}
{"level":"info","ts":"2026-02-20T15:59:25.005827Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"}
{"level":"info","ts":"2026-02-20T15:59:25.005982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-20T15:59:25.006016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"}
{"level":"info","ts":"2026-02-20T15:59:25.006061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-20T15:59:25.006089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"}
{"level":"info","ts":"2026-02-20T15:59:25.006139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"}
{"level":"warn","ts":"2026-02-20T15:59:25.025148Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-20T15:59:25.026405Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-20T15:59:25.029031Z","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-02-20T15:59:25.031992Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-20T15:59:25.032352Z","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-02-20T15:59:25.032397Z","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-02-20T15:59:25.032436Z","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-02-20T15:59:25.032577Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-20T15:59:25.034747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"}
{"level":"info","ts":"2026-02-20T15:59:25.034995Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]}
{"level":"info","ts":"2026-02-20T15:59:25.042414Z","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-02-20T15:59:25.042638Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"}
{"level":"info","ts":"2026-02-20T15:59:25.042693Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"}
{"level":"info","ts":"2026-02-20T15:59:25.04413Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-20T15:59:25.044183Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-20T15:59:25.507894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-20T15:59:25.50799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-20T15:59:25.508029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"}
{"level":"info","ts":"2026-02-20T15:59:25.508049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"}
{"level":"info","ts":"2026-02-20T15:59:25.508061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"}
{"level":"info","ts":"2026-02-20T15:59:25.508073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"}
{"level":"info","ts":"2026-02-20T15:59:25.508088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"}
{"level":"info","ts":"2026-02-20T15:59:25.509058Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T15:59:25.510126Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-20T15:59:25.510142Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-20T15:59:25.510286Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-20T15:59:25.510327Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-20T15:59:25.510217Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-20T15:59:25.510637Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T15:59:25.51076Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T15:59:25.5108Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-20T15:59:25.513447Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-20T15:59:25.515043Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"}
{"level":"info","ts":"2026-02-20T15:59:28.430414Z","caller":"traceutil/trace.go:171","msg":"trace[613912448] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"120.801044ms","start":"2026-02-20T15:59:28.309578Z","end":"2026-02-20T15:59:28.430379Z","steps":["trace[613912448] 'read index received'  (duration: 120.115829ms)","trace[613912448] 'applied index is now lower than readState.Index'  (duration: 684.195µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:28.43062Z","caller":"traceutil/trace.go:171","msg":"trace[1063351372] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"123.186291ms","start":"2026-02-20T15:59:28.307399Z","end":"2026-02-20T15:59:28.430585Z","steps":["trace[1063351372] 'process raft request'  (duration: 122.202443ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:28.430876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.262348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-20T15:59:28.431013Z","caller":"traceutil/trace.go:171","msg":"trace[1468905126] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:0; response_revision:73; }","duration":"121.433319ms","start":"2026-02-20T15:59:28.309554Z","end":"2026-02-20T15:59:28.430987Z","steps":["trace[1468905126] 'agreement among raft nodes before linearized reading'  (duration: 121.124007ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:59:28.692209Z","caller":"traceutil/trace.go:171","msg":"trace[1633968918] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"181.21514ms","start":"2026-02-20T15:59:28.510957Z","end":"2026-02-20T15:59:28.692173Z","steps":["trace[1633968918] 'process raft request'  (duration: 121.307948ms)","trace[1633968918] 'compare'  (duration: 59.738571ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:29.019509Z","caller":"traceutil/trace.go:171","msg":"trace[502921649] transaction","detail":"{read_only:false; response_revision:83; number_of_response:1; }","duration":"236.426008ms","start":"2026-02-20T15:59:28.783048Z","end":"2026-02-20T15:59:29.019474Z","steps":["trace[502921649] 'process raft request'  (duration: 151.861414ms)","trace[502921649] 'compare'  (duration: 84.323042ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:29.274492Z","caller":"traceutil/trace.go:171","msg":"trace[1702583625] transaction","detail":"{read_only:false; response_revision:85; number_of_response:1; }","duration":"204.474035ms","start":"2026-02-20T15:59:29.069987Z","end":"2026-02-20T15:59:29.274461Z","steps":["trace[1702583625] 'process raft request'  (duration: 132.246154ms)","trace[1702583625] 'compare'  (duration: 72.0702ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:29.79877Z","caller":"traceutil/trace.go:171","msg":"trace[1757652418] linearizableReadLoop","detail":"{readStateIndex:98; appliedIndex:97; }","duration":"339.683681ms","start":"2026-02-20T15:59:29.459059Z","end":"2026-02-20T15:59:29.798742Z","steps":["trace[1757652418] 'read index received'  (duration: 269.328393ms)","trace[1757652418] 'applied index is now lower than readState.Index'  (duration: 70.353708ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:29.798939Z","caller":"traceutil/trace.go:171","msg":"trace[1406880542] transaction","detail":"{read_only:false; response_revision:94; number_of_response:1; }","duration":"348.461966ms","start":"2026-02-20T15:59:29.450464Z","end":"2026-02-20T15:59:29.798926Z","steps":["trace[1406880542] 'process raft request'  (duration: 277.940447ms)","trace[1406880542] 'compare'  (duration: 70.201157ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:59:29.799311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.231465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-20T15:59:29.799419Z","caller":"traceutil/trace.go:171","msg":"trace[1651988754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:94; }","duration":"340.377906ms","start":"2026-02-20T15:59:29.45902Z","end":"2026-02-20T15:59:29.799398Z","steps":["trace[1651988754] 'agreement among raft nodes before linearized reading'  (duration: 340.222555ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:29.799493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:29.459006Z","time spent":"340.455697ms","remote":"127.0.0.1:46564","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-02-20T15:59:29.799798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:29.450432Z","time spent":"348.595587ms","remote":"127.0.0.1:46882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1026,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/clusterroles/system:kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:kube-controller-manager\" value_size:965 >> failure:<>"}
{"level":"info","ts":"2026-02-20T15:59:30.029649Z","caller":"traceutil/trace.go:171","msg":"trace[1656770226] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"156.570003ms","start":"2026-02-20T15:59:29.873044Z","end":"2026-02-20T15:59:30.029614Z","steps":["trace[1656770226] 'process raft request'  (duration: 57.061071ms)","trace[1656770226] 'compare'  (duration: 99.28001ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:33.615497Z","caller":"traceutil/trace.go:171","msg":"trace[1123457045] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"147.625489ms","start":"2026-02-20T15:59:33.467849Z","end":"2026-02-20T15:59:33.615475Z","steps":["trace[1123457045] 'process raft request'  (duration: 119.284964ms)","trace[1123457045] 'compare'  (duration: 28.240184ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:34.060638Z","caller":"traceutil/trace.go:171","msg":"trace[1250347519] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:322; }","duration":"557.181685ms","start":"2026-02-20T15:59:33.503421Z","end":"2026-02-20T15:59:34.060603Z","steps":["trace[1250347519] 'read index received'  (duration: 83.684196ms)","trace[1250347519] 'applied index is now lower than readState.Index'  (duration: 473.496159ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:34.060702Z","caller":"traceutil/trace.go:171","msg":"trace[19758149] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"590.516636ms","start":"2026-02-20T15:59:33.470146Z","end":"2026-02-20T15:59:34.060662Z","steps":["trace[19758149] 'process raft request'  (duration: 581.662853ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:34.060945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.496307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-20T15:59:34.06107Z","caller":"traceutil/trace.go:171","msg":"trace[427297467] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:314; }","duration":"557.624878ms","start":"2026-02-20T15:59:33.503409Z","end":"2026-02-20T15:59:34.061034Z","steps":["trace[427297467] 'agreement among raft nodes before linearized reading'  (duration: 557.383966ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:34.061131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:33.503395Z","time spent":"557.725179ms","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-20T15:59:34.061275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:33.470125Z","time spent":"590.852259ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:214 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-20T15:59:34.064692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.548869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5489"}
{"level":"info","ts":"2026-02-20T15:59:34.064755Z","caller":"traceutil/trace.go:171","msg":"trace[1664902211] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:314; }","duration":"473.672159ms","start":"2026-02-20T15:59:33.591066Z","end":"2026-02-20T15:59:34.064738Z","steps":["trace[1664902211] 'agreement among raft nodes before linearized reading'  (duration: 473.543568ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:34.064821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:33.591042Z","time spent":"473.76963ms","remote":"127.0.0.1:46756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5512,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "}
{"level":"info","ts":"2026-02-20T15:59:34.064881Z","caller":"traceutil/trace.go:171","msg":"trace[419557191] transaction","detail":"{read_only:false; number_of_response:0; response_revision:314; }","duration":"418.992974ms","start":"2026-02-20T15:59:33.645845Z","end":"2026-02-20T15:59:34.064838Z","steps":["trace[419557191] 'process raft request'  (duration: 418.737012ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:59:34.064944Z","caller":"traceutil/trace.go:171","msg":"trace[381319098] transaction","detail":"{read_only:false; number_of_response:0; response_revision:314; }","duration":"419.94359ms","start":"2026-02-20T15:59:33.644969Z","end":"2026-02-20T15:59:34.064912Z","steps":["trace[381319098] 'process raft request'  (duration: 419.553668ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:34.064986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.608753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T15:59:34.065024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:33.645838Z","time spent":"419.116275ms","remote":"127.0.0.1:46756","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5409 >> failure:<>"}
{"level":"warn","ts":"2026-02-20T15:59:34.065026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:33.644952Z","time spent":"420.035961ms","remote":"127.0.0.1:46756","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2825 >> failure:<>"}
{"level":"info","ts":"2026-02-20T15:59:34.065054Z","caller":"traceutil/trace.go:171","msg":"trace[1267204055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:314; }","duration":"468.719123ms","start":"2026-02-20T15:59:33.596315Z","end":"2026-02-20T15:59:34.065034Z","steps":["trace[1267204055] 'agreement among raft nodes before linearized reading'  (duration: 468.559612ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:34.065104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:33.596292Z","time spent":"468.803054ms","remote":"127.0.0.1:46564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T15:59:44.59977Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836958658793787826,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T15:59:45.013248Z","caller":"traceutil/trace.go:171","msg":"trace[1152586313] linearizableReadLoop","detail":"{readStateIndex:434; appliedIndex:433; }","duration":"914.011857ms","start":"2026-02-20T15:59:44.099192Z","end":"2026-02-20T15:59:45.013204Z","steps":["trace[1152586313] 'read index received'  (duration: 913.761866ms)","trace[1152586313] 'applied index is now lower than readState.Index'  (duration: 248.971µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:45.013418Z","caller":"traceutil/trace.go:171","msg":"trace[1180459921] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"924.757374ms","start":"2026-02-20T15:59:44.088644Z","end":"2026-02-20T15:59:45.013401Z","steps":["trace[1180459921] 'process raft request'  (duration: 924.390109ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:45.013637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:44.088625Z","time spent":"924.837877ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:410 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-20T15:59:45.013816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.5951ms","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-02-20T15:59:45.013935Z","caller":"traceutil/trace.go:171","msg":"trace[601774784] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:420; }","duration":"914.742416ms","start":"2026-02-20T15:59:44.099167Z","end":"2026-02-20T15:59:45.013909Z","steps":["trace[601774784] 'agreement among raft nodes before linearized reading'  (duration: 914.565369ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:45.013993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:44.099156Z","time spent":"914.826939ms","remote":"127.0.0.1:46810","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":"warn","ts":"2026-02-20T15:59:45.013996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.305091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"}
{"level":"warn","ts":"2026-02-20T15:59:45.013959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.064147ms","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-02-20T15:59:45.014052Z","caller":"traceutil/trace.go:171","msg":"trace[997535505] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:420; }","duration":"293.425047ms","start":"2026-02-20T15:59:44.720612Z","end":"2026-02-20T15:59:45.014037Z","steps":["trace[997535505] 'agreement among raft nodes before linearized reading'  (duration: 293.323973ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:59:45.014095Z","caller":"traceutil/trace.go:171","msg":"trace[1612687830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:420; }","duration":"865.246115ms","start":"2026-02-20T15:59:44.148813Z","end":"2026-02-20T15:59:45.014059Z","steps":["trace[1612687830] 'agreement among raft nodes before linearized reading'  (duration: 864.952473ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:45.014187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:44.148796Z","time spent":"865.37444ms","remote":"127.0.0.1:46810","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-02-20T15:59:45.014166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.008224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:59:45.014292Z","caller":"traceutil/trace.go:171","msg":"trace[1961299033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:420; }","duration":"387.221523ms","start":"2026-02-20T15:59:44.627037Z","end":"2026-02-20T15:59:45.014259Z","steps":["trace[1961299033] 'agreement among raft nodes before linearized reading'  (duration: 386.937601ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:45.014355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:44.627012Z","time spent":"387.333617ms","remote":"127.0.0.1:46564","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-02-20T15:59:45.15066Z","caller":"traceutil/trace.go:171","msg":"trace[1438104501] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"131.043486ms","start":"2026-02-20T15:59:45.019585Z","end":"2026-02-20T15:59:45.150629Z","steps":["trace[1438104501] 'process raft request'  (duration: 89.560938ms)","trace[1438104501] 'compare'  (duration: 41.332822ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:45.311705Z","caller":"traceutil/trace.go:171","msg":"trace[1054725006] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"291.811134ms","start":"2026-02-20T15:59:45.019868Z","end":"2026-02-20T15:59:45.311679Z","steps":["trace[1054725006] 'process raft request'  (duration: 291.493601ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:59:45.311732Z","caller":"traceutil/trace.go:171","msg":"trace[1737539180] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"276.41458ms","start":"2026-02-20T15:59:45.03528Z","end":"2026-02-20T15:59:45.311695Z","steps":["trace[1737539180] 'process raft request'  (duration: 276.322236ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:51.487075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.181719ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836958658793787900 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.246\" mod_revision:408 > success:<request_put:<key:\"/registry/masterleases/199.204.45.246\" value_size:67 lease:1613586621939012089 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.246\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T15:59:51.487252Z","caller":"traceutil/trace.go:171","msg":"trace[139382397] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"410.27739ms","start":"2026-02-20T15:59:51.076947Z","end":"2026-02-20T15:59:51.487225Z","steps":["trace[139382397] 'process raft request'  (duration: 244.521139ms)","trace[139382397] 'compare'  (duration: 164.834496ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:59:51.487352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:51.076919Z","time spent":"410.389564ms","remote":"127.0.0.1:46592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.246\" mod_revision:408 > success:<request_put:<key:\"/registry/masterleases/199.204.45.246\" value_size:67 lease:1613586621939012089 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.246\" > >"}
{"level":"info","ts":"2026-02-20T15:59:51.569174Z","caller":"traceutil/trace.go:171","msg":"trace[1695627992] linearizableReadLoop","detail":"{readStateIndex:480; appliedIndex:478; }","duration":"394.004643ms","start":"2026-02-20T15:59:51.17513Z","end":"2026-02-20T15:59:51.569135Z","steps":["trace[1695627992] 'read index received'  (duration: 146.342804ms)","trace[1695627992] 'applied index is now lower than readState.Index'  (duration: 247.660599ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:51.569217Z","caller":"traceutil/trace.go:171","msg":"trace[1756691488] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"489.946201ms","start":"2026-02-20T15:59:51.079229Z","end":"2026-02-20T15:59:51.569175Z","steps":["trace[1756691488] 'process raft request'  (duration: 489.720773ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:51.569361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.206741ms","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-02-20T15:59:51.569451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:51.079213Z","time spent":"490.094206ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:458 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-20T15:59:51.569462Z","caller":"traceutil/trace.go:171","msg":"trace[913625595] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:463; }","duration":"394.358157ms","start":"2026-02-20T15:59:51.17508Z","end":"2026-02-20T15:59:51.569439Z","steps":["trace[913625595] 'agreement among raft nodes before linearized reading'  (duration: 394.187261ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:51.569476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.818195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-02-20T15:59:51.569515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:51.175054Z","time spent":"394.448571ms","remote":"127.0.0.1:46810","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-02-20T15:59:51.569547Z","caller":"traceutil/trace.go:171","msg":"trace[990404390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:463; }","duration":"234.92935ms","start":"2026-02-20T15:59:51.334594Z","end":"2026-02-20T15:59:51.569523Z","steps":["trace[990404390] 'agreement among raft nodes before linearized reading'  (duration: 234.778674ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:52.074861Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836958658793787904,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T15:59:52.575596Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836958658793787904,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T15:59:52.779469Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.205081421s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-20T15:59:52.779974Z","caller":"traceutil/trace.go:171","msg":"trace[1951751209] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"1.205666542s","start":"2026-02-20T15:59:51.574276Z","end":"2026-02-20T15:59:52.779943Z","steps":["trace[1951751209] 'process raft request'  (duration: 1.205490346s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:52.780152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:51.574254Z","time spent":"1.205804968s","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:460 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-20T15:59:52.782184Z","caller":"traceutil/trace.go:171","msg":"trace[2101927875] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:480; }","duration":"1.207561565s","start":"2026-02-20T15:59:51.574599Z","end":"2026-02-20T15:59:52.78216Z","steps":["trace[2101927875] 'read index received'  (duration: 1.205163944s)","trace[2101927875] 'applied index is now lower than readState.Index'  (duration: 2.396531ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:52.782392Z","caller":"traceutil/trace.go:171","msg":"trace[1988929742] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"1.206183331s","start":"2026-02-20T15:59:51.5762Z","end":"2026-02-20T15:59:52.782383Z","steps":["trace[1988929742] 'process raft request'  (duration: 1.205860949s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:52.782493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:51.576183Z","time spent":"1.206237164s","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:459 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-20T15:59:52.782717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.208085845s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-02-20T15:59:52.782793Z","caller":"traceutil/trace.go:171","msg":"trace[2056805341] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:465; }","duration":"1.208191229s","start":"2026-02-20T15:59:51.574584Z","end":"2026-02-20T15:59:52.782776Z","steps":["trace[2056805341] 'agreement among raft nodes before linearized reading'  (duration: 1.208023423s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:52.782834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:51.574577Z","time spent":"1.208251371s","remote":"127.0.0.1:46818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"warn","ts":"2026-02-20T15:59:52.782946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081048221s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-20T15:59:52.783026Z","caller":"traceutil/trace.go:171","msg":"trace[1549251789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:465; }","duration":"1.081189697s","start":"2026-02-20T15:59:51.701814Z","end":"2026-02-20T15:59:52.783004Z","steps":["trace[1549251789] 'agreement among raft nodes before linearized reading'  (duration: 1.08101s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T15:59:52.783077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:51.701791Z","time spent":"1.08127613s","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-20T15:59:52.783096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.658775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T15:59:52.783118Z","caller":"traceutil/trace.go:171","msg":"trace[1246018678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:465; }","duration":"185.732068ms","start":"2026-02-20T15:59:52.597379Z","end":"2026-02-20T15:59:52.783111Z","steps":["trace[1246018678] 'agreement among raft nodes before linearized reading'  (duration: 185.696276ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T15:59:54.967071Z","caller":"traceutil/trace.go:171","msg":"trace[564711763] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"143.050036ms","start":"2026-02-20T15:59:54.823984Z","end":"2026-02-20T15:59:54.967034Z","steps":["trace[564711763] 'read index received'  (duration: 127.258208ms)","trace[564711763] 'applied index is now lower than readState.Index'  (duration: 15.790398ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T15:59:54.967137Z","caller":"traceutil/trace.go:171","msg":"trace[335697615] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"177.849419ms","start":"2026-02-20T15:59:54.789239Z","end":"2026-02-20T15:59:54.967088Z","steps":["trace[335697615] 'process raft request'  (duration: 162.043991ms)","trace[335697615] 'compare'  (duration: 15.60225ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T15:59:54.967292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.252922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-20T15:59:54.967419Z","caller":"traceutil/trace.go:171","msg":"trace[989225596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:470; }","duration":"143.467261ms","start":"2026-02-20T15:59:54.823919Z","end":"2026-02-20T15:59:54.967386Z","steps":["trace[989225596] 'agreement among raft nodes before linearized reading'  (duration: 143.195331ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:00.873379Z","caller":"traceutil/trace.go:171","msg":"trace[1965138693] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"275.490733ms","start":"2026-02-20T16:00:00.597829Z","end":"2026-02-20T16:00:00.873319Z","steps":["trace[1965138693] 'read index received'  (duration: 275.293367ms)","trace[1965138693] 'applied index is now lower than readState.Index'  (duration: 195.946µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:00:00.873642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.777943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:00:00.873508Z","caller":"traceutil/trace.go:171","msg":"trace[732107672] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.21175844s","start":"2026-02-20T15:59:59.661666Z","end":"2026-02-20T16:00:00.873424Z","steps":["trace[732107672] 'process raft request'  (duration: 1.21147151s)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:00.873797Z","caller":"traceutil/trace.go:171","msg":"trace[1931835343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"275.997702ms","start":"2026-02-20T16:00:00.597769Z","end":"2026-02-20T16:00:00.873767Z","steps":["trace[1931835343] 'agreement among raft nodes before linearized reading'  (duration: 275.749872ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:00.873963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T15:59:59.661643Z","time spent":"1.212195295s","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:484 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-20T16:00:01.447821Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836958658793788019,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T16:00:01.460666Z","caller":"traceutil/trace.go:171","msg":"trace[1977389463] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"581.780996ms","start":"2026-02-20T16:00:00.878848Z","end":"2026-02-20T16:00:01.460629Z","steps":["trace[1977389463] 'process raft request'  (duration: 570.060622ms)","trace[1977389463] 'compare'  (duration: 11.556338ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:00:01.460899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:00.878821Z","time spent":"581.974431ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:512 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-20T16:00:01.460859Z","caller":"traceutil/trace.go:171","msg":"trace[584744572] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:533; }","duration":"513.78719ms","start":"2026-02-20T16:00:00.947017Z","end":"2026-02-20T16:00:01.460804Z","steps":["trace[584744572] 'read index received'  (duration: 501.88119ms)","trace[584744572] 'applied index is now lower than readState.Index'  (duration: 11.901009ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:00:01.461084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.027398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4021"}
{"level":"info","ts":"2026-02-20T16:00:01.461169Z","caller":"traceutil/trace.go:171","msg":"trace[816681721] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:516; }","duration":"514.176552ms","start":"2026-02-20T16:00:00.946975Z","end":"2026-02-20T16:00:01.461152Z","steps":["trace[816681721] 'agreement among raft nodes before linearized reading'  (duration: 513.969295ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:01.461099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.021301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-20T16:00:01.46145Z","caller":"traceutil/trace.go:171","msg":"trace[1400498360] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:516; }","duration":"500.408833ms","start":"2026-02-20T16:00:00.960978Z","end":"2026-02-20T16:00:01.461387Z","steps":["trace[1400498360] 'agreement among raft nodes before linearized reading'  (duration: 500.054871ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:01.461695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:00.960945Z","time spent":"500.705514ms","remote":"127.0.0.1:46592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.246\" "}
{"level":"warn","ts":"2026-02-20T16:00:01.461216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:00.946961Z","time spent":"514.246325ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4044,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-20T16:00:01.461246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.291928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-20T16:00:01.462185Z","caller":"traceutil/trace.go:171","msg":"trace[789067648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:516; }","duration":"416.249773ms","start":"2026-02-20T16:00:01.045913Z","end":"2026-02-20T16:00:01.462162Z","steps":["trace[789067648] 'agreement among raft nodes before linearized reading'  (duration: 415.226617ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:01.462247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:01.045891Z","time spent":"416.340405ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-20T16:00:01.46131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.704906ms","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-02-20T16:00:01.462545Z","caller":"traceutil/trace.go:171","msg":"trace[124585367] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"468.960981ms","start":"2026-02-20T16:00:00.993557Z","end":"2026-02-20T16:00:01.462518Z","steps":["trace[124585367] 'agreement among raft nodes before linearized reading'  (duration: 467.666066ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:01.462612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:00.993539Z","time spent":"469.054474ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-20T16:00:03.14631Z","caller":"traceutil/trace.go:171","msg":"trace[1194953413] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"252.96991ms","start":"2026-02-20T16:00:02.893306Z","end":"2026-02-20T16:00:03.146276Z","steps":["trace[1194953413] 'process raft request'  (duration: 252.767714ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:03.148416Z","caller":"traceutil/trace.go:171","msg":"trace[1824593513] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"176.399003ms","start":"2026-02-20T16:00:02.971996Z","end":"2026-02-20T16:00:03.148395Z","steps":["trace[1824593513] 'process raft request'  (duration: 176.304269ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:08.025399Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836958658793788098,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T16:00:08.353706Z","caller":"traceutil/trace.go:171","msg":"trace[1248836961] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"828.435076ms","start":"2026-02-20T16:00:07.525248Z","end":"2026-02-20T16:00:08.353683Z","steps":["trace[1248836961] 'read index received'  (duration: 828.339923ms)","trace[1248836961] 'applied index is now lower than readState.Index'  (duration: 94.273µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:00:08.35393Z","caller":"traceutil/trace.go:171","msg":"trace[1732617574] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"858.108905ms","start":"2026-02-20T16:00:07.495779Z","end":"2026-02-20T16:00:08.353888Z","steps":["trace[1732617574] 'process raft request'  (duration: 857.780494ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:08.354151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:07.495757Z","time spent":"858.273909ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:549 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-20T16:00:08.354205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.921111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-20T16:00:08.354323Z","caller":"traceutil/trace.go:171","msg":"trace[2102489959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:553; }","duration":"829.117078ms","start":"2026-02-20T16:00:07.525177Z","end":"2026-02-20T16:00:08.354294Z","steps":["trace[2102489959] 'agreement among raft nodes before linearized reading'  (duration: 828.741036ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:08.354445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:07.525146Z","time spent":"829.280323ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-20T16:00:08.606182Z","caller":"traceutil/trace.go:171","msg":"trace[1389056794] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"252.351661ms","start":"2026-02-20T16:00:08.353788Z","end":"2026-02-20T16:00:08.606139Z","steps":["trace[1389056794] 'read index received'  (duration: 252.287749ms)","trace[1389056794] 'applied index is now lower than readState.Index'  (duration: 61.612µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:00:08.606196Z","caller":"traceutil/trace.go:171","msg":"trace[343342397] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"569.269806ms","start":"2026-02-20T16:00:08.036889Z","end":"2026-02-20T16:00:08.606159Z","steps":["trace[343342397] 'process raft request'  (duration: 568.856233ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:08.606483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:08.03686Z","time spent":"569.470132ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:509 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-20T16:00:08.606491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.07993696s","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-02-20T16:00:08.606484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.003479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:00:08.606574Z","caller":"traceutil/trace.go:171","msg":"trace[452425710] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"1.080071354s","start":"2026-02-20T16:00:07.526482Z","end":"2026-02-20T16:00:08.606553Z","steps":["trace[452425710] 'agreement among raft nodes before linearized reading'  (duration: 1.079804926s)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:08.606604Z","caller":"traceutil/trace.go:171","msg":"trace[1037124077] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"890.149064ms","start":"2026-02-20T16:00:07.716425Z","end":"2026-02-20T16:00:08.606574Z","steps":["trace[1037124077] 'agreement among raft nodes before linearized reading'  (duration: 889.756782ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:08.606621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:07.526458Z","time spent":"1.080151527s","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-20T16:00:08.606675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:07.716364Z","time spent":"890.295769ms","remote":"127.0.0.1:46564","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-02-20T16:00:08.877361Z","caller":"traceutil/trace.go:171","msg":"trace[58716975] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:574; }","duration":"270.978057ms","start":"2026-02-20T16:00:08.606277Z","end":"2026-02-20T16:00:08.877255Z","steps":["trace[58716975] 'read index received'  (duration: 265.76173ms)","trace[58716975] 'applied index is now lower than readState.Index'  (duration: 5.213387ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:00:08.877654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.367017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:00:08.87772Z","caller":"traceutil/trace.go:171","msg":"trace[972612558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:555; }","duration":"280.49395ms","start":"2026-02-20T16:00:08.597196Z","end":"2026-02-20T16:00:08.87769Z","steps":["trace[972612558] 'agreement among raft nodes before linearized reading'  (duration: 280.256713ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:08.878417Z","caller":"traceutil/trace.go:171","msg":"trace[38605158] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"518.589377ms","start":"2026-02-20T16:00:08.359805Z","end":"2026-02-20T16:00:08.878395Z","steps":["trace[38605158] 'process raft request'  (duration: 512.284175ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:08.87855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:08.359775Z","time spent":"518.69409ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:550 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-20T16:00:09.159691Z","caller":"traceutil/trace.go:171","msg":"trace[1825177570] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"547.603963ms","start":"2026-02-20T16:00:08.612056Z","end":"2026-02-20T16:00:09.15966Z","steps":["trace[1825177570] 'process raft request'  (duration: 498.194891ms)","trace[1825177570] 'compare'  (duration: 49.248867ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:00:09.159865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:08.61203Z","time spent":"547.735167ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:551 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-20T16:00:10.720548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.55453ms","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-02-20T16:00:10.720689Z","caller":"traceutil/trace.go:171","msg":"trace[249874817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:560; }","duration":"359.83094ms","start":"2026-02-20T16:00:10.360828Z","end":"2026-02-20T16:00:10.720659Z","steps":["trace[249874817] 'range keys from in-memory index tree'  (duration: 359.299042ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:10.720746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:10.360762Z","time spent":"359.971654ms","remote":"127.0.0.1:46810","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-02-20T16:00:11.271023Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836958658793788115,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T16:00:11.706684Z","caller":"traceutil/trace.go:171","msg":"trace[158362132] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"981.640802ms","start":"2026-02-20T16:00:10.725018Z","end":"2026-02-20T16:00:11.706659Z","steps":["trace[158362132] 'process raft request'  (duration: 981.400464ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:11.706637Z","caller":"traceutil/trace.go:171","msg":"trace[810767375] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"936.22192ms","start":"2026-02-20T16:00:10.770385Z","end":"2026-02-20T16:00:11.706606Z","steps":["trace[810767375] 'read index received'  (duration: 935.954872ms)","trace[810767375] 'applied index is now lower than readState.Index'  (duration: 265.838µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:00:11.706892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:10.724975Z","time spent":"981.787537ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:553 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-20T16:00:11.707018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.435301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T16:00:11.707041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.047529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"warn","ts":"2026-02-20T16:00:11.707086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.07407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-20T16:00:11.707118Z","caller":"traceutil/trace.go:171","msg":"trace[888122661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"110.616687ms","start":"2026-02-20T16:00:11.596475Z","end":"2026-02-20T16:00:11.707091Z","steps":["trace[888122661] 'agreement among raft nodes before linearized reading'  (duration: 110.466332ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:11.707116Z","caller":"traceutil/trace.go:171","msg":"trace[1433223867] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:561; }","duration":"462.176134ms","start":"2026-02-20T16:00:11.244922Z","end":"2026-02-20T16:00:11.707098Z","steps":["trace[1433223867] 'agreement among raft nodes before linearized reading'  (duration: 461.961527ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:11.707138Z","caller":"traceutil/trace.go:171","msg":"trace[698273694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"823.165123ms","start":"2026-02-20T16:00:10.88396Z","end":"2026-02-20T16:00:11.707125Z","steps":["trace[698273694] 'agreement among raft nodes before linearized reading'  (duration: 822.912045ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:11.707122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.697986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-28qvj\" ","response":"range_response_count:1 size:16656"}
{"level":"warn","ts":"2026-02-20T16:00:11.707168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:11.244892Z","time spent":"462.263557ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T16:00:11.707176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.216263ms","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-02-20T16:00:11.707249Z","caller":"traceutil/trace.go:171","msg":"trace[757911919] range","detail":"{range_begin:/registry/pods/kube-system/cilium-28qvj; range_end:; response_count:1; response_revision:561; }","duration":"936.882671ms","start":"2026-02-20T16:00:10.770329Z","end":"2026-02-20T16:00:11.707211Z","steps":["trace[757911919] 'agreement among raft nodes before linearized reading'  (duration: 936.470279ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:11.707271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.489022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-02-20T16:00:11.70718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:10.883936Z","time spent":"823.235695ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-20T16:00:11.707291Z","caller":"traceutil/trace.go:171","msg":"trace[1304795962] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"542.411059ms","start":"2026-02-20T16:00:11.164851Z","end":"2026-02-20T16:00:11.707262Z","steps":["trace[1304795962] 'agreement among raft nodes before linearized reading'  (duration: 542.036377ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:11.707306Z","caller":"traceutil/trace.go:171","msg":"trace[934444813] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:561; }","duration":"745.543493ms","start":"2026-02-20T16:00:10.961752Z","end":"2026-02-20T16:00:11.707296Z","steps":["trace[934444813] 'agreement among raft nodes before linearized reading'  (duration: 745.45339ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:11.707319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:10.770297Z","time spent":"937.011035ms","remote":"127.0.0.1:46756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-28qvj\" "}
{"level":"warn","ts":"2026-02-20T16:00:11.707336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:10.961496Z","time spent":"745.834732ms","remote":"127.0.0.1:46592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.246\" "}
{"level":"warn","ts":"2026-02-20T16:00:11.707351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:11.164819Z","time spent":"542.522052ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-20T16:00:12.24357Z","caller":"traceutil/trace.go:171","msg":"trace[1862125694] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"531.915608ms","start":"2026-02-20T16:00:11.711627Z","end":"2026-02-20T16:00:12.243543Z","steps":["trace[1862125694] 'process raft request'  (duration: 531.748193ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:12.243663Z","caller":"traceutil/trace.go:171","msg":"trace[1722048348] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"520.275089ms","start":"2026-02-20T16:00:11.723375Z","end":"2026-02-20T16:00:12.24365Z","steps":["trace[1722048348] 'process raft request'  (duration: 520.204977ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:12.24374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:11.723345Z","time spent":"520.352031ms","remote":"127.0.0.1:46756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-28qvj\" mod_revision:507 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-28qvj\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-28qvj\" > >"}
{"level":"warn","ts":"2026-02-20T16:00:12.24374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:11.711619Z","time spent":"532.032313ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:557 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-20T16:00:12.243871Z","caller":"traceutil/trace.go:171","msg":"trace[1263323407] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"532.299471ms","start":"2026-02-20T16:00:11.711519Z","end":"2026-02-20T16:00:12.243818Z","steps":["trace[1263323407] 'process raft request'  (duration: 514.848506ms)","trace[1263323407] 'compare'  (duration: 16.63035ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:00:12.24398Z","caller":"traceutil/trace.go:171","msg":"trace[1221740766] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"530.654219ms","start":"2026-02-20T16:00:11.713273Z","end":"2026-02-20T16:00:12.243928Z","steps":["trace[1221740766] 'process raft request'  (duration: 530.226476ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:12.244135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:11.711488Z","time spent":"532.509167ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:555 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-20T16:00:12.244248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:11.713244Z","time spent":"530.869606ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:556 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-20T16:00:12.326342Z","caller":"traceutil/trace.go:171","msg":"trace[1931657556] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"441.38807ms","start":"2026-02-20T16:00:11.884924Z","end":"2026-02-20T16:00:12.326312Z","steps":["trace[1931657556] 'process raft request'  (duration: 441.217854ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:12.326538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:11.88489Z","time spent":"441.551004ms","remote":"127.0.0.1:46592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.246\" mod_revision:519 > success:<request_put:<key:\"/registry/masterleases/199.204.45.246\" value_size:67 lease:1613586621939012312 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.246\" > >"}
{"level":"warn","ts":"2026-02-20T16:00:14.097687Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836958658793788129,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-20T16:00:14.31137Z","caller":"traceutil/trace.go:171","msg":"trace[213766406] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"714.147988ms","start":"2026-02-20T16:00:13.597191Z","end":"2026-02-20T16:00:14.311339Z","steps":["trace[213766406] 'read index received'  (duration: 713.89088ms)","trace[213766406] 'applied index is now lower than readState.Index'  (duration: 255.887µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:00:14.31151Z","caller":"traceutil/trace.go:171","msg":"trace[1019305567] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"972.824526ms","start":"2026-02-20T16:00:13.338649Z","end":"2026-02-20T16:00:14.311473Z","steps":["trace[1019305567] 'process raft request'  (duration: 972.464866ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:14.311704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:13.338605Z","time spent":"972.995071ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:522 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-20T16:00:14.311658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.436677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-20T16:00:14.31176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.658963ms","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-02-20T16:00:14.31179Z","caller":"traceutil/trace.go:171","msg":"trace[1059496982] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:567; }","duration":"714.636742ms","start":"2026-02-20T16:00:13.597126Z","end":"2026-02-20T16:00:14.311763Z","steps":["trace[1059496982] 'agreement among raft nodes before linearized reading'  (duration: 714.422806ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:14.31181Z","caller":"traceutil/trace.go:171","msg":"trace[307272530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:567; }","duration":"600.785907ms","start":"2026-02-20T16:00:13.711008Z","end":"2026-02-20T16:00:14.311793Z","steps":["trace[307272530] 'agreement among raft nodes before linearized reading'  (duration: 600.55803ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:14.311846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:13.597096Z","time spent":"714.737205ms","remote":"127.0.0.1:46564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T16:00:14.311861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:13.710981Z","time spent":"600.87128ms","remote":"127.0.0.1:46810","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-02-20T16:00:15.17246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.355368ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836958658793788135 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:563 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-20T16:00:15.172707Z","caller":"traceutil/trace.go:171","msg":"trace[739419547] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"854.024335ms","start":"2026-02-20T16:00:14.318664Z","end":"2026-02-20T16:00:15.172688Z","steps":["trace[739419547] 'process raft request'  (duration: 853.979584ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:15.172761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:14.318649Z","time spent":"854.088798ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:561 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-20T16:00:15.172762Z","caller":"traceutil/trace.go:171","msg":"trace[2048756184] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"855.598023ms","start":"2026-02-20T16:00:14.317113Z","end":"2026-02-20T16:00:15.172711Z","steps":["trace[2048756184] 'process raft request'  (duration: 433.850823ms)","trace[2048756184] 'compare'  (duration: 421.211144ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:00:15.173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:14.317088Z","time spent":"855.804439ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:563 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-20T16:00:15.173031Z","caller":"traceutil/trace.go:171","msg":"trace[511452162] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"854.419037ms","start":"2026-02-20T16:00:14.318577Z","end":"2026-02-20T16:00:15.172997Z","steps":["trace[511452162] 'process raft request'  (duration: 853.982344ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:15.173198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:14.31857Z","time spent":"854.53294ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:562 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-20T16:00:17.677333Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836958658793788139,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-20T16:00:17.897237Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.3116373s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-20T16:00:17.99471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.654789536s","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-02-20T16:00:17.99471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.399723831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:00:17.994814Z","caller":"traceutil/trace.go:171","msg":"trace[1592607444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:571; }","duration":"1.654908659s","start":"2026-02-20T16:00:16.33988Z","end":"2026-02-20T16:00:17.994788Z","steps":["trace[1592607444] 'range keys from in-memory index tree'  (duration: 1.654532098s)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:17.994829Z","caller":"traceutil/trace.go:171","msg":"trace[1889560028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"2.399913407s","start":"2026-02-20T16:00:15.594891Z","end":"2026-02-20T16:00:17.994804Z","steps":["trace[1889560028] 'range keys from in-memory index tree'  (duration: 2.399603246s)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:17.994868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:16.339768Z","time spent":"1.655086874s","remote":"127.0.0.1:46810","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":"warn","ts":"2026-02-20T16:00:17.994881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:15.594862Z","time spent":"2.400008678s","remote":"127.0.0.1:46564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T16:00:18.052278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.79245ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836958658793788140 > lease_revoke:<id:16649c7bc6ff5277>","response":"size:28"}
{"level":"info","ts":"2026-02-20T16:00:18.052642Z","caller":"traceutil/trace.go:171","msg":"trace[1160112151] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"875.439199ms","start":"2026-02-20T16:00:17.177153Z","end":"2026-02-20T16:00:18.052592Z","steps":["trace[1160112151] 'read index received'  (duration: 720.248248ms)","trace[1160112151] 'applied index is now lower than readState.Index'  (duration: 155.183151ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-20T16:00:18.053175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.998234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-20T16:00:18.05323Z","caller":"traceutil/trace.go:171","msg":"trace[1346596224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:572; }","duration":"876.132409ms","start":"2026-02-20T16:00:17.177082Z","end":"2026-02-20T16:00:18.053215Z","steps":["trace[1346596224] 'agreement among raft nodes before linearized reading'  (duration: 875.770248ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:18.053274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.741957ms","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-02-20T16:00:18.053325Z","caller":"traceutil/trace.go:171","msg":"trace[1890803416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:572; }","duration":"875.85158ms","start":"2026-02-20T16:00:17.177453Z","end":"2026-02-20T16:00:18.053305Z","steps":["trace[1890803416] 'agreement among raft nodes before linearized reading'  (duration: 875.679695ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:18.053371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:17.177424Z","time spent":"875.934113ms","remote":"127.0.0.1:46810","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-02-20T16:00:18.053452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:17.177056Z","time spent":"876.358105ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-20T16:00:18.053525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.00857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:00:18.053554Z","caller":"traceutil/trace.go:171","msg":"trace[1471719298] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"337.066832ms","start":"2026-02-20T16:00:17.716478Z","end":"2026-02-20T16:00:18.053544Z","steps":["trace[1471719298] 'agreement among raft nodes before linearized reading'  (duration: 337.020881ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:18.05358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:17.716457Z","time spent":"337.117254ms","remote":"127.0.0.1:46564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T16:00:18.053733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.314647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:00:18.053758Z","caller":"traceutil/trace.go:171","msg":"trace[1265801402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"458.391809ms","start":"2026-02-20T16:00:17.595358Z","end":"2026-02-20T16:00:18.05375Z","steps":["trace[1265801402] 'agreement among raft nodes before linearized reading'  (duration: 458.351038ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:18.053784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:17.595328Z","time spent":"458.451371ms","remote":"127.0.0.1:46568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T16:00:18.053995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.86059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-20T16:00:18.054064Z","caller":"traceutil/trace.go:171","msg":"trace[2014999881] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:572; }","duration":"875.960553ms","start":"2026-02-20T16:00:17.178093Z","end":"2026-02-20T16:00:18.054054Z","steps":["trace[2014999881] 'agreement among raft nodes before linearized reading'  (duration: 875.820169ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:18.054092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:17.178066Z","time spent":"876.019475ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T16:00:18.922919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.889879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-28qvj\" ","response":"range_response_count:1 size:16818"}
{"level":"info","ts":"2026-02-20T16:00:18.922978Z","caller":"traceutil/trace.go:171","msg":"trace[483039844] range","detail":"{range_begin:/registry/pods/kube-system/cilium-28qvj; range_end:; response_count:1; response_revision:577; }","duration":"130.015732ms","start":"2026-02-20T16:00:18.792955Z","end":"2026-02-20T16:00:18.922971Z","steps":["trace[483039844] 'agreement among raft nodes before linearized reading'  (duration: 129.819067ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:18.922744Z","caller":"traceutil/trace.go:171","msg":"trace[1602721760] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"186.494903ms","start":"2026-02-20T16:00:18.736237Z","end":"2026-02-20T16:00:18.922731Z","steps":["trace[1602721760] 'process raft request'  (duration: 186.207944ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:00:18.922682Z","caller":"traceutil/trace.go:171","msg":"trace[836389737] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"129.650203ms","start":"2026-02-20T16:00:18.793007Z","end":"2026-02-20T16:00:18.922657Z","steps":["trace[836389737] 'read index received'  (duration: 129.56292ms)","trace[836389737] 'applied index is now lower than readState.Index'  (duration: 86.232µs)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:00:18.942164Z","caller":"traceutil/trace.go:171","msg":"trace[794947996] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"147.26168ms","start":"2026-02-20T16:00:18.79489Z","end":"2026-02-20T16:00:18.942152Z","steps":["trace[794947996] 'process raft request'  (duration: 147.175408ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:20.590507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.05943ms","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-02-20T16:00:20.590591Z","caller":"traceutil/trace.go:171","msg":"trace[256722907] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"532.202225ms","start":"2026-02-20T16:00:20.058369Z","end":"2026-02-20T16:00:20.590572Z","steps":["trace[256722907] 'range keys from in-memory index tree'  (duration: 531.881745ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:20.590628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:20.058342Z","time spent":"532.277866ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-20T16:00:20.590852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.791601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-20T16:00:20.590903Z","caller":"traceutil/trace.go:171","msg":"trace[966877553] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"496.862234ms","start":"2026-02-20T16:00:20.09403Z","end":"2026-02-20T16:00:20.590892Z","steps":["trace[966877553] 'range keys from in-memory index tree'  (duration: 496.704659ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:20.59093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:20.094019Z","time spent":"496.904434ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-20T16:00:20.591327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.896945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-20T16:00:20.591418Z","caller":"traceutil/trace.go:171","msg":"trace[1076207339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"497.056529ms","start":"2026-02-20T16:00:20.094339Z","end":"2026-02-20T16:00:20.591395Z","steps":["trace[1076207339] 'range keys from in-memory index tree'  (duration: 496.708529ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:20.591476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:20.094329Z","time spent":"497.136392ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-20T16:00:20.591551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.656188ms","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-02-20T16:00:20.591606Z","caller":"traceutil/trace.go:171","msg":"trace[1534841807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:588; }","duration":"496.72752ms","start":"2026-02-20T16:00:20.094867Z","end":"2026-02-20T16:00:20.591595Z","steps":["trace[1534841807] 'range keys from in-memory index tree'  (duration: 496.573835ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:00:20.591642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:00:20.094859Z","time spent":"496.771731ms","remote":"127.0.0.1:46810","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-02-20T16:00:23.227529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.454868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"}
{"level":"info","ts":"2026-02-20T16:00:23.227615Z","caller":"traceutil/trace.go:171","msg":"trace[722027798] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:645; }","duration":"206.607342ms","start":"2026-02-20T16:00:23.020989Z","end":"2026-02-20T16:00:23.227596Z","steps":["trace[722027798] 'range keys from in-memory index tree'  (duration: 206.283854ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:01:11.761959Z","caller":"traceutil/trace.go:171","msg":"trace[1563838575] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"111.827785ms","start":"2026-02-20T16:01:11.650105Z","end":"2026-02-20T16:01:11.761933Z","steps":["trace[1563838575] 'process raft request'  (duration: 111.628901ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:01:11.762125Z","caller":"traceutil/trace.go:171","msg":"trace[1977840798] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"111.02874ms","start":"2026-02-20T16:01:11.651068Z","end":"2026-02-20T16:01:11.762097Z","steps":["trace[1977840798] 'process raft request'  (duration: 110.818506ms)"],"step_count":1}
{"level":"info","ts":"2026-02-20T16:01:50.165697Z","caller":"traceutil/trace.go:171","msg":"trace[898239696] linearizableReadLoop","detail":"{readStateIndex:1072; appliedIndex:1070; }","duration":"218.283509ms","start":"2026-02-20T16:01:49.947395Z","end":"2026-02-20T16:01:50.165679Z","steps":["trace[898239696] 'read index received'  (duration: 23.450825ms)","trace[898239696] 'applied index is now lower than readState.Index'  (duration: 194.831984ms)"],"step_count":2}
{"level":"info","ts":"2026-02-20T16:01:50.165758Z","caller":"traceutil/trace.go:171","msg":"trace[281327674] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"230.326281ms","start":"2026-02-20T16:01:49.935404Z","end":"2026-02-20T16:01:50.16573Z","steps":["trace[281327674] 'process raft request'  (duration: 224.869748ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:01:50.165934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.795716ms","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-02-20T16:01:50.165961Z","caller":"traceutil/trace.go:171","msg":"trace[1351204210] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1026; }","duration":"216.861067ms","start":"2026-02-20T16:01:49.949093Z","end":"2026-02-20T16:01:50.165954Z","steps":["trace[1351204210] 'agreement among raft nodes before linearized reading'  (duration: 216.701174ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:01:50.165956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.541693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-20T16:01:50.166041Z","caller":"traceutil/trace.go:171","msg":"trace[1153149579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1026; }","duration":"218.674705ms","start":"2026-02-20T16:01:49.947343Z","end":"2026-02-20T16:01:50.166017Z","steps":["trace[1153149579] 'agreement among raft nodes before linearized reading'  (duration: 218.414681ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:01:51.250039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.613898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-20T16:01:51.250165Z","caller":"traceutil/trace.go:171","msg":"trace[960024256] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1029; }","duration":"643.833611ms","start":"2026-02-20T16:01:50.606305Z","end":"2026-02-20T16:01:51.250139Z","steps":["trace[960024256] 'range keys from in-memory index tree'  (duration: 643.441525ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-20T16:01:51.250229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T16:01:50.606281Z","time spent":"643.935943ms","remote":"127.0.0.1:46564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-20T16:01:51.250426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.584546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-20T16:01:51.250503Z","caller":"traceutil/trace.go:171","msg":"trace[71571298] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:1029; }","duration":"280.711169ms","start":"2026-02-20T16:01:50.969772Z","end":"2026-02-20T16:01:51.250483Z","steps":["trace[71571298] 'range keys from in-memory index tree'  (duration: 280.371003ms)"],"step_count":1}