{"level":"warn","ts":"2026-01-28T01:06:19.883267Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-28T01:06:19.883406Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.70: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://162.253.55.70:2380","--initial-cluster=instance=https://162.253.55.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.70: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-01-28T01:06:19.883489Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-28T01:06:19.883734Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.70:2380"]}
{"level":"info","ts":"2026-01-28T01:06:19.883774Z","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-01-28T01:06:19.887685Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.70:2379"]}
{"level":"info","ts":"2026-01-28T01:06:19.888618Z","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":2,"max-cpu-available":2,"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://162.253.55.70:2380"],"listen-peer-urls":["https://162.253.55.70:2380"],"advertise-client-urls":["https://162.253.55.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.70: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-01-28T01:06:19.899026Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.54796ms"}
{"level":"info","ts":"2026-01-28T01:06:19.91278Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"23887246632736aa","cluster-id":"62cfeca3ef46d3ef"}
{"level":"info","ts":"2026-01-28T01:06:19.912887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa switched to configuration voters=()"}
{"level":"info","ts":"2026-01-28T01:06:19.912923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became follower at term 0"}
{"level":"info","ts":"2026-01-28T01:06:19.912948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 23887246632736aa [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-28T01:06:19.912965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became follower at term 1"}
{"level":"info","ts":"2026-01-28T01:06:19.913009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa switched to configuration voters=(2560422034796918442)"}
{"level":"warn","ts":"2026-01-28T01:06:19.932367Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-28T01:06:19.943581Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-28T01:06:19.956365Z","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-01-28T01:06:19.980119Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"23887246632736aa","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-28T01:06:19.980646Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"23887246632736aa","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-28T01:06:19.980797Z","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-01-28T01:06:19.980846Z","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-01-28T01:06:19.980868Z","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-01-28T01:06:19.981679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa switched to configuration voters=(2560422034796918442)"}
{"level":"info","ts":"2026-01-28T01:06:19.981895Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62cfeca3ef46d3ef","local-member-id":"23887246632736aa","added-peer-id":"23887246632736aa","added-peer-peer-urls":["https://162.253.55.70:2380"]}
{"level":"info","ts":"2026-01-28T01:06:19.995998Z","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-01-28T01:06:19.99629Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"23887246632736aa","initial-advertise-peer-urls":["https://162.253.55.70:2380"],"listen-peer-urls":["https://162.253.55.70:2380"],"advertise-client-urls":["https://162.253.55.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-28T01:06:19.996916Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.70:2380"}
{"level":"info","ts":"2026-01-28T01:06:20.00109Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.70:2380"}
{"level":"info","ts":"2026-01-28T01:06:19.997352Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-28T01:06:20.913372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa is starting a new election at term 1"}
{"level":"info","ts":"2026-01-28T01:06:20.913487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-28T01:06:20.913545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa received MsgPreVoteResp from 23887246632736aa at term 1"}
{"level":"info","ts":"2026-01-28T01:06:20.913593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became candidate at term 2"}
{"level":"info","ts":"2026-01-28T01:06:20.913638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa received MsgVoteResp from 23887246632736aa at term 2"}
{"level":"info","ts":"2026-01-28T01:06:20.913678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became leader at term 2"}
{"level":"info","ts":"2026-01-28T01:06:20.913721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 23887246632736aa elected leader 23887246632736aa at term 2"}
{"level":"info","ts":"2026-01-28T01:06:20.915641Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"23887246632736aa","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.70:2379]}","request-path":"/0/members/23887246632736aa/attributes","cluster-id":"62cfeca3ef46d3ef","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-28T01:06:20.915715Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-28T01:06:20.915783Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-28T01:06:20.916107Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-28T01:06:20.917454Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-28T01:06:20.920351Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62cfeca3ef46d3ef","local-member-id":"23887246632736aa","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-28T01:06:20.920447Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-28T01:06:20.920494Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-28T01:06:20.920453Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-28T01:06:20.920908Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-28T01:06:20.921854Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.70:2379"}
{"level":"info","ts":"2026-01-28T01:06:31.521509Z","caller":"traceutil/trace.go:171","msg":"trace[856062951] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"572.423503ms","start":"2026-01-28T01:06:30.949062Z","end":"2026-01-28T01:06:31.521485Z","steps":["trace[856062951] 'process raft request'  (duration: 572.311482ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:31.523003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:30.949048Z","time spent":"572.537313ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":197,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" value_size:128 >> failure:<>"}
{"level":"warn","ts":"2026-01-28T01:06:37.945881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.330151231s","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-01-28T01:06:37.945959Z","caller":"traceutil/trace.go:171","msg":"trace[1026536573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:418; }","duration":"1.330269125s","start":"2026-01-28T01:06:36.615675Z","end":"2026-01-28T01:06:37.945944Z","steps":["trace[1026536573] 'range keys from in-memory index tree'  (duration: 1.330087039s)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:37.945986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:36.615663Z","time spent":"1.330316196s","remote":"127.0.0.1:38480","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-01-28T01:06:37.946135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.324927102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-01-28T01:06:37.946162Z","caller":"traceutil/trace.go:171","msg":"trace[1960172884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:418; }","duration":"1.324991784s","start":"2026-01-28T01:06:36.621163Z","end":"2026-01-28T01:06:37.946155Z","steps":["trace[1960172884] 'range keys from in-memory index tree'  (duration: 1.324874051s)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:37.946184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:36.621147Z","time spent":"1.325032325s","remote":"127.0.0.1:38480","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-01-28T01:06:37.946425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.103479161s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4018"}
{"level":"info","ts":"2026-01-28T01:06:37.94645Z","caller":"traceutil/trace.go:171","msg":"trace[2086945736] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:418; }","duration":"1.103503692s","start":"2026-01-28T01:06:36.84294Z","end":"2026-01-28T01:06:37.946444Z","steps":["trace[2086945736] 'range keys from in-memory index tree'  (duration: 1.10340468s)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:37.946466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:36.842897Z","time spent":"1.103565833s","remote":"127.0.0.1:38370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4040,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-01-28T01:06:37.946576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.101858569s","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-01-28T01:06:37.946593Z","caller":"traceutil/trace.go:171","msg":"trace[423139126] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:418; }","duration":"1.10192812s","start":"2026-01-28T01:06:36.84466Z","end":"2026-01-28T01:06:37.946588Z","steps":["trace[423139126] 'range keys from in-memory index tree'  (duration: 1.101760367s)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:37.94661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:36.844645Z","time spent":"1.101961591s","remote":"127.0.0.1:38480","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-01-28T01:06:37.94697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.278875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:06:37.946994Z","caller":"traceutil/trace.go:171","msg":"trace[1966846269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:418; }","duration":"811.331037ms","start":"2026-01-28T01:06:37.135658Z","end":"2026-01-28T01:06:37.946989Z","steps":["trace[1966846269] 'range keys from in-memory index tree'  (duration: 811.231223ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:37.94701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:37.135643Z","time spent":"811.362769ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-28T01:06:50.641852Z","caller":"traceutil/trace.go:171","msg":"trace[1347216878] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"119.383467ms","start":"2026-01-28T01:06:50.522451Z","end":"2026-01-28T01:06:50.641834Z","steps":["trace[1347216878] 'process raft request'  (duration: 44.442031ms)","trace[1347216878] 'compare'  (duration: 73.482534ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:06:50.724569Z","caller":"traceutil/trace.go:171","msg":"trace[1757280310] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"108.917808ms","start":"2026-01-28T01:06:50.615629Z","end":"2026-01-28T01:06:50.724547Z","steps":["trace[1757280310] 'process raft request'  (duration: 100.530474ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:06:50.891022Z","caller":"traceutil/trace.go:171","msg":"trace[2127917512] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"238.946002ms","start":"2026-01-28T01:06:50.652044Z","end":"2026-01-28T01:06:50.89099Z","steps":["trace[2127917512] 'process raft request'  (duration: 224.364964ms)","trace[2127917512] 'compare'  (duration: 14.35079ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:06:50.891692Z","caller":"traceutil/trace.go:171","msg":"trace[1104939990] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"239.565045ms","start":"2026-01-28T01:06:50.652108Z","end":"2026-01-28T01:06:50.891673Z","steps":["trace[1104939990] 'process raft request'  (duration: 238.826958ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:06:50.891891Z","caller":"traceutil/trace.go:171","msg":"trace[1662947108] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"236.407151ms","start":"2026-01-28T01:06:50.655474Z","end":"2026-01-28T01:06:50.891882Z","steps":["trace[1662947108] 'process raft request'  (duration: 235.82383ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:06:50.892048Z","caller":"traceutil/trace.go:171","msg":"trace[1341281168] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"239.800243ms","start":"2026-01-28T01:06:50.652239Z","end":"2026-01-28T01:06:50.89204Z","steps":["trace[1341281168] 'process raft request'  (duration: 238.940203ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:06:50.892273Z","caller":"traceutil/trace.go:171","msg":"trace[140066050] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"239.98047ms","start":"2026-01-28T01:06:50.652283Z","end":"2026-01-28T01:06:50.892264Z","steps":["trace[140066050] 'process raft request'  (duration: 238.971343ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:53.395981Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939132357081468243,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-28T01:06:53.896362Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939132357081468243,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-28T01:06:54.397019Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939132357081468243,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-28T01:06:54.897817Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939132357081468243,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-28T01:06:55.134297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000084869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-01-28T01:06:55.134377Z","caller":"traceutil/trace.go:171","msg":"trace[1851415173] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000179162s","start":"2026-01-28T01:06:53.134179Z","end":"2026-01-28T01:06:55.134359Z","steps":["trace[1851415173] 'agreement among raft nodes before linearized reading'  (duration: 2.000081549s)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:55.134445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:53.134147Z","time spent":"2.000288686s","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-01-28T01:06:55.185529Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.371234722s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-28T01:06:55.185884Z","caller":"traceutil/trace.go:171","msg":"trace[1134657037] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:531; }","duration":"2.289980103s","start":"2026-01-28T01:06:52.895889Z","end":"2026-01-28T01:06:55.185869Z","steps":["trace[1134657037] 'read index received'  (duration: 2.289806086s)","trace[1134657037] 'applied index is now lower than readState.Index'  (duration: 173.027µs)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:06:55.185985Z","caller":"traceutil/trace.go:171","msg":"trace[1200370196] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"2.371791122s","start":"2026-01-28T01:06:52.814186Z","end":"2026-01-28T01:06:55.185977Z","steps":["trace[1200370196] 'process raft request'  (duration: 2.371535583s)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:55.186159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.165151353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.70\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-01-28T01:06:55.18621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:52.814171Z","time spent":"2.371844174s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:460 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-01-28T01:06:55.186209Z","caller":"traceutil/trace.go:171","msg":"trace[925196381] range","detail":"{range_begin:/registry/masterleases/162.253.55.70; range_end:; response_count:1; response_revision:518; }","duration":"1.165265008s","start":"2026-01-28T01:06:54.020925Z","end":"2026-01-28T01:06:55.18619Z","steps":["trace[925196381] 'agreement among raft nodes before linearized reading'  (duration: 1.165177455s)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:55.186251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:54.020909Z","time spent":"1.165331699s","remote":"127.0.0.1:38172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/162.253.55.70\" "}
{"level":"warn","ts":"2026-01-28T01:06:55.186514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.39979ms","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-01-28T01:06:55.186534Z","caller":"traceutil/trace.go:171","msg":"trace[551368291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:518; }","duration":"920.434502ms","start":"2026-01-28T01:06:54.266093Z","end":"2026-01-28T01:06:55.186528Z","steps":["trace[551368291] 'agreement among raft nodes before linearized reading'  (duration: 920.346949ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:55.186564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:54.266085Z","time spent":"920.475533ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-28T01:06:55.18658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.407139ms","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-01-28T01:06:55.186622Z","caller":"traceutil/trace.go:171","msg":"trace[1748017148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"922.511333ms","start":"2026-01-28T01:06:54.264098Z","end":"2026-01-28T01:06:55.186609Z","steps":["trace[1748017148] 'agreement among raft nodes before linearized reading'  (duration: 922.355317ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:55.186658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.29077363s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-28T01:06:55.186676Z","caller":"traceutil/trace.go:171","msg":"trace[1972872793] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:518; }","duration":"2.290821142s","start":"2026-01-28T01:06:52.89585Z","end":"2026-01-28T01:06:55.186671Z","steps":["trace[1972872793] 'agreement among raft nodes before linearized reading'  (duration: 2.29076417s)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:55.186706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:52.895813Z","time spent":"2.290889994s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-01-28T01:06:55.18674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036494934s","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-01-28T01:06:55.186771Z","caller":"traceutil/trace.go:171","msg":"trace[2031378571] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"1.036581427s","start":"2026-01-28T01:06:54.150179Z","end":"2026-01-28T01:06:55.18676Z","steps":["trace[2031378571] 'agreement among raft nodes before linearized reading'  (duration: 1.036491174s)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:55.186797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:54.150163Z","time spent":"1.036629028s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-28T01:06:55.186652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:54.264083Z","time spent":"922.562035ms","remote":"127.0.0.1:38480","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-01-28T01:06:55.700359Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939132357081468248,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-28T01:06:55.995272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.527236ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:06:55.995436Z","caller":"traceutil/trace.go:171","msg":"trace[228681091] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:518; }","duration":"105.715343ms","start":"2026-01-28T01:06:55.889698Z","end":"2026-01-28T01:06:55.995413Z","steps":["trace[228681091] 'range keys from in-memory index tree'  (duration: 105.503785ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:55.995863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:55.193284Z","time spent":"802.574169ms","remote":"127.0.0.1:38172","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-01-28T01:06:56.008277Z","caller":"traceutil/trace.go:171","msg":"trace[1920695596] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:532; }","duration":"808.744309ms","start":"2026-01-28T01:06:55.199512Z","end":"2026-01-28T01:06:56.008256Z","steps":["trace[1920695596] 'read index received'  (duration: 784.560832ms)","trace[1920695596] 'applied index is now lower than readState.Index'  (duration: 24.182037ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-28T01:06:56.00845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.915925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:06:56.00849Z","caller":"traceutil/trace.go:171","msg":"trace[1653200380] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"809.000048ms","start":"2026-01-28T01:06:55.199479Z","end":"2026-01-28T01:06:56.008479Z","steps":["trace[1653200380] 'agreement among raft nodes before linearized reading'  (duration: 808.898084ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:56.008528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:55.199472Z","time spent":"809.046949ms","remote":"127.0.0.1:38130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-28T01:06:56.008775Z","caller":"traceutil/trace.go:171","msg":"trace[834122485] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"815.256881ms","start":"2026-01-28T01:06:55.193508Z","end":"2026-01-28T01:06:56.008765Z","steps":["trace[834122485] 'process raft request'  (duration: 814.441634ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:56.008836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:55.193501Z","time spent":"815.299973ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.188ebfa41d346c27\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.188ebfa41d346c27\" value_size:672 lease:3939132357081467287 >> failure:<>"}
{"level":"info","ts":"2026-01-28T01:06:56.009048Z","caller":"traceutil/trace.go:171","msg":"trace[610821256] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"809.405621ms","start":"2026-01-28T01:06:55.199635Z","end":"2026-01-28T01:06:56.009041Z","steps":["trace[610821256] 'process raft request'  (duration: 808.466129ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:56.009096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:55.199628Z","time spent":"809.440673ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:514 > 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-01-28T01:06:56.009177Z","caller":"traceutil/trace.go:171","msg":"trace[1999184294] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"809.474913ms","start":"2026-01-28T01:06:55.199696Z","end":"2026-01-28T01:06:56.009171Z","steps":["trace[1999184294] 'process raft request'  (duration: 808.455829ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:56.009209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:55.19969Z","time spent":"809.500575ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:513 > 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-01-28T01:06:56.009283Z","caller":"traceutil/trace.go:171","msg":"trace[1651155457] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"809.545176ms","start":"2026-01-28T01:06:55.199732Z","end":"2026-01-28T01:06:56.009277Z","steps":["trace[1651155457] 'process raft request'  (duration: 808.456479ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:56.009314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:55.199713Z","time spent":"809.583027ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:515 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-01-28T01:06:56.00939Z","caller":"traceutil/trace.go:171","msg":"trace[3511660] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"809.63998ms","start":"2026-01-28T01:06:55.199744Z","end":"2026-01-28T01:06:56.009384Z","steps":["trace[3511660] 'process raft request'  (duration: 808.47398ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:06:56.009425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:06:55.199739Z","time spent":"809.668711ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:495 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-01-28T01:06:56.132592Z","caller":"traceutil/trace.go:171","msg":"trace[271553146] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"119.411367ms","start":"2026-01-28T01:06:56.013143Z","end":"2026-01-28T01:06:56.132554Z","steps":["trace[271553146] 'process raft request'  (duration: 87.524257ms)","trace[271553146] 'compare'  (duration: 31.428795ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:06:57.129108Z","caller":"traceutil/trace.go:171","msg":"trace[532075047] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"134.032637ms","start":"2026-01-28T01:06:56.995058Z","end":"2026-01-28T01:06:57.129091Z","steps":["trace[532075047] 'process raft request'  (duration: 129.858838ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:06:58.236145Z","caller":"traceutil/trace.go:171","msg":"trace[1039892537] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"204.593785ms","start":"2026-01-28T01:06:58.031532Z","end":"2026-01-28T01:06:58.236125Z","steps":["trace[1039892537] 'process raft request'  (duration: 138.545945ms)","trace[1039892537] 'compare'  (duration: 65.961847ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:07:03.249868Z","caller":"traceutil/trace.go:171","msg":"trace[1876571023] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"116.070186ms","start":"2026-01-28T01:07:03.133779Z","end":"2026-01-28T01:07:03.249849Z","steps":["trace[1876571023] 'read index received'  (duration: 115.908101ms)","trace[1876571023] 'applied index is now lower than readState.Index'  (duration: 161.405µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-28T01:07:03.24998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.18188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:03.250006Z","caller":"traceutil/trace.go:171","msg":"trace[797237828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"116.257662ms","start":"2026-01-28T01:07:03.133738Z","end":"2026-01-28T01:07:03.249996Z","steps":["trace[797237828] 'agreement among raft nodes before linearized reading'  (duration: 116.182039ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:03.250107Z","caller":"traceutil/trace.go:171","msg":"trace[225428382] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"383.479295ms","start":"2026-01-28T01:07:02.866609Z","end":"2026-01-28T01:07:03.250088Z","steps":["trace[225428382] 'process raft request'  (duration: 383.137924ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:03.2502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:07:02.866576Z","time spent":"383.569527ms","remote":"127.0.0.1:38384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-wcc2x\" mod_revision:510 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-wcc2x\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-wcc2x\" > >"}
{"level":"info","ts":"2026-01-28T01:07:04.2155Z","caller":"traceutil/trace.go:171","msg":"trace[817550267] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"177.867439ms","start":"2026-01-28T01:07:04.037616Z","end":"2026-01-28T01:07:04.215483Z","steps":["trace[817550267] 'read index received'  (duration: 177.795347ms)","trace[817550267] 'applied index is now lower than readState.Index'  (duration: 70.852µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-28T01:07:04.215661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.032844ms","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-01-28T01:07:04.215681Z","caller":"traceutil/trace.go:171","msg":"trace[314650330] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:564; }","duration":"178.090566ms","start":"2026-01-28T01:07:04.037584Z","end":"2026-01-28T01:07:04.215675Z","steps":["trace[314650330] 'agreement among raft nodes before linearized reading'  (duration: 177.988693ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:04.215839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.497566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-01-28T01:07:04.215862Z","caller":"traceutil/trace.go:171","msg":"trace[1541836286] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:564; }","duration":"166.536218ms","start":"2026-01-28T01:07:04.049313Z","end":"2026-01-28T01:07:04.215849Z","steps":["trace[1541836286] 'agreement among raft nodes before linearized reading'  (duration: 166.495216ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:04.215985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.483515ms","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-01-28T01:07:04.215998Z","caller":"traceutil/trace.go:171","msg":"trace[1797887315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:564; }","duration":"166.519416ms","start":"2026-01-28T01:07:04.049475Z","end":"2026-01-28T01:07:04.215995Z","steps":["trace[1797887315] 'agreement among raft nodes before linearized reading'  (duration: 166.480095ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:04.425345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.885948ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939132357081468348 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.70\" mod_revision:524 > success:<request_put:<key:\"/registry/masterleases/162.253.55.70\" value_size:66 lease:3939132357081468344 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.70\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-28T01:07:04.425522Z","caller":"traceutil/trace.go:171","msg":"trace[244646952] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"201.503623ms","start":"2026-01-28T01:07:04.224007Z","end":"2026-01-28T01:07:04.42551Z","steps":["trace[244646952] 'process raft request'  (duration: 201.41418ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:04.425571Z","caller":"traceutil/trace.go:171","msg":"trace[550429642] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:581; }","duration":"206.298943ms","start":"2026-01-28T01:07:04.21925Z","end":"2026-01-28T01:07:04.425549Z","steps":["trace[550429642] 'read index received'  (duration: 2.053934ms)","trace[550429642] 'applied index is now lower than readState.Index'  (duration: 204.243879ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:07:04.425633Z","caller":"traceutil/trace.go:171","msg":"trace[2040278921] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"208.354778ms","start":"2026-01-28T01:07:04.217272Z","end":"2026-01-28T01:07:04.425626Z","steps":["trace[2040278921] 'compare'  (duration: 203.748914ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:04.425743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.493239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:04.42576Z","caller":"traceutil/trace.go:171","msg":"trace[1317607204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"206.572752ms","start":"2026-01-28T01:07:04.219182Z","end":"2026-01-28T01:07:04.425755Z","steps":["trace[1317607204] 'agreement among raft nodes before linearized reading'  (duration: 206.544341ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:04.438847Z","caller":"traceutil/trace.go:171","msg":"trace[1918358880] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"214.678224ms","start":"2026-01-28T01:07:04.224158Z","end":"2026-01-28T01:07:04.438836Z","steps":["trace[1918358880] 'process raft request'  (duration: 214.472447ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:04.438953Z","caller":"traceutil/trace.go:171","msg":"trace[1893218945] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"214.741335ms","start":"2026-01-28T01:07:04.224207Z","end":"2026-01-28T01:07:04.438948Z","steps":["trace[1893218945] 'process raft request'  (duration: 214.484227ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:04.439065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.611395ms","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-01-28T01:07:04.439082Z","caller":"traceutil/trace.go:171","msg":"trace[104531102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:568; }","duration":"189.671076ms","start":"2026-01-28T01:07:04.249406Z","end":"2026-01-28T01:07:04.439077Z","steps":["trace[104531102] 'agreement among raft nodes before linearized reading'  (duration: 189.591184ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:05.555021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.064264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:05.555069Z","caller":"traceutil/trace.go:171","msg":"trace[1691627702] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"148.158737ms","start":"2026-01-28T01:07:05.406898Z","end":"2026-01-28T01:07:05.555057Z","steps":["trace[1691627702] 'range keys from in-memory index tree'  (duration: 148.012633ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:06.409944Z","caller":"traceutil/trace.go:171","msg":"trace[116621554] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"892.576703ms","start":"2026-01-28T01:07:05.517352Z","end":"2026-01-28T01:07:06.409929Z","steps":["trace[116621554] 'process raft request'  (duration: 892.4806ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:06.410038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:07:05.517336Z","time spent":"892.651995ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:518 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-01-28T01:07:06.410334Z","caller":"traceutil/trace.go:171","msg":"trace[404676164] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:587; }","duration":"277.231248ms","start":"2026-01-28T01:07:06.133097Z","end":"2026-01-28T01:07:06.410328Z","steps":["trace[404676164] 'read index received'  (duration: 277.229188ms)","trace[404676164] 'applied index is now lower than readState.Index'  (duration: 1.56µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-28T01:07:06.410386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.287199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:06.4104Z","caller":"traceutil/trace.go:171","msg":"trace[360085386] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"277.327391ms","start":"2026-01-28T01:07:06.133068Z","end":"2026-01-28T01:07:06.410396Z","steps":["trace[360085386] 'agreement among raft nodes before linearized reading'  (duration: 277.3002ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:09.282493Z","caller":"traceutil/trace.go:171","msg":"trace[88385311] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"137.721294ms","start":"2026-01-28T01:07:09.144754Z","end":"2026-01-28T01:07:09.282475Z","steps":["trace[88385311] 'read index received'  (duration: 136.047474ms)","trace[88385311] 'applied index is now lower than readState.Index'  (duration: 1.67306ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:07:09.282682Z","caller":"traceutil/trace.go:171","msg":"trace[1939060774] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"138.087364ms","start":"2026-01-28T01:07:09.144582Z","end":"2026-01-28T01:07:09.282669Z","steps":["trace[1939060774] 'process raft request'  (duration: 136.23355ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:09.283243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.476636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:09.283278Z","caller":"traceutil/trace.go:171","msg":"trace[1262721689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"138.533587ms","start":"2026-01-28T01:07:09.144735Z","end":"2026-01-28T01:07:09.283268Z","steps":["trace[1262721689] 'agreement among raft nodes before linearized reading'  (duration: 138.472065ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:09.288784Z","caller":"traceutil/trace.go:171","msg":"trace[993974226] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"143.69914ms","start":"2026-01-28T01:07:09.145075Z","end":"2026-01-28T01:07:09.288775Z","steps":["trace[993974226] 'process raft request'  (duration: 143.450792ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:09.289015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.032097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:09.290422Z","caller":"traceutil/trace.go:171","msg":"trace[1090720726] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:602; }","duration":"128.468349ms","start":"2026-01-28T01:07:09.161946Z","end":"2026-01-28T01:07:09.290415Z","steps":["trace[1090720726] 'agreement among raft nodes before linearized reading'  (duration: 127.032497ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:09.290485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.458108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:09.290513Z","caller":"traceutil/trace.go:171","msg":"trace[1312009165] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:602; }","duration":"128.49046ms","start":"2026-01-28T01:07:09.162014Z","end":"2026-01-28T01:07:09.290505Z","steps":["trace[1312009165] 'agreement among raft nodes before linearized reading'  (duration: 128.452839ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:09.290557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.544701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:09.29057Z","caller":"traceutil/trace.go:171","msg":"trace[1961579011] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:602; }","duration":"128.563242ms","start":"2026-01-28T01:07:09.162002Z","end":"2026-01-28T01:07:09.290565Z","steps":["trace[1961579011] 'agreement among raft nodes before linearized reading'  (duration: 128.546811ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:09.289181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.13496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:09.290596Z","caller":"traceutil/trace.go:171","msg":"trace[1837463570] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:602; }","duration":"128.555171ms","start":"2026-01-28T01:07:09.162035Z","end":"2026-01-28T01:07:09.29059Z","steps":["trace[1837463570] 'agreement among raft nodes before linearized reading'  (duration: 127.12938ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:09.290634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.633794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:09.290646Z","caller":"traceutil/trace.go:171","msg":"trace[960794955] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:602; }","duration":"128.652994ms","start":"2026-01-28T01:07:09.161989Z","end":"2026-01-28T01:07:09.290642Z","steps":["trace[960794955] 'agreement among raft nodes before linearized reading'  (duration: 128.635273ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:09.290254Z","caller":"traceutil/trace.go:171","msg":"trace[1344722191] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"115.217439ms","start":"2026-01-28T01:07:09.175028Z","end":"2026-01-28T01:07:09.290245Z","steps":["trace[1344722191] 'process raft request'  (duration: 113.670924ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:09.431838Z","caller":"traceutil/trace.go:171","msg":"trace[1980518683] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"112.572261ms","start":"2026-01-28T01:07:09.319239Z","end":"2026-01-28T01:07:09.431811Z","steps":["trace[1980518683] 'process raft request'  (duration: 82.451142ms)","trace[1980518683] 'compare'  (duration: 30.021266ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:07:11.391923Z","caller":"traceutil/trace.go:171","msg":"trace[245129520] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"263.359771ms","start":"2026-01-28T01:07:11.128548Z","end":"2026-01-28T01:07:11.391908Z","steps":["trace[245129520] 'process raft request'  (duration: 257.46465ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:11.392078Z","caller":"traceutil/trace.go:171","msg":"trace[231313213] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"219.557026ms","start":"2026-01-28T01:07:11.172479Z","end":"2026-01-28T01:07:11.392036Z","steps":["trace[231313213] 'read index received'  (duration: 216.710543ms)","trace[231313213] 'applied index is now lower than readState.Index'  (duration: 2.845263ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:07:11.39219Z","caller":"traceutil/trace.go:171","msg":"trace[1017628291] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"219.533825ms","start":"2026-01-28T01:07:11.172651Z","end":"2026-01-28T01:07:11.392185Z","steps":["trace[1017628291] 'process raft request'  (duration: 219.121052ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:11.392542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.133953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-01-28T01:07:11.392604Z","caller":"traceutil/trace.go:171","msg":"trace[421409196] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:641; }","duration":"219.210964ms","start":"2026-01-28T01:07:11.173382Z","end":"2026-01-28T01:07:11.392593Z","steps":["trace[421409196] 'agreement among raft nodes before linearized reading'  (duration: 219.075981ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:11.392791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.310467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:11.392828Z","caller":"traceutil/trace.go:171","msg":"trace[1274565387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"220.367839ms","start":"2026-01-28T01:07:11.172454Z","end":"2026-01-28T01:07:11.392822Z","steps":["trace[1274565387] 'agreement among raft nodes before linearized reading'  (duration: 220.319708ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:16.883921Z","caller":"traceutil/trace.go:171","msg":"trace[1152940939] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"166.219057ms","start":"2026-01-28T01:07:16.717687Z","end":"2026-01-28T01:07:16.883906Z","steps":["trace[1152940939] 'process raft request'  (duration: 96.563033ms)","trace[1152940939] 'compare'  (duration: 69.546911ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:07:27.361616Z","caller":"traceutil/trace.go:171","msg":"trace[2142550962] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:806; }","duration":"226.576211ms","start":"2026-01-28T01:07:27.135015Z","end":"2026-01-28T01:07:27.361591Z","steps":["trace[2142550962] 'read index received'  (duration: 225.085135ms)","trace[2142550962] 'applied index is now lower than readState.Index'  (duration: 1.490046ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-28T01:07:27.362151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.118644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:07:27.362222Z","caller":"traceutil/trace.go:171","msg":"trace[1073846762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:783; }","duration":"227.221067ms","start":"2026-01-28T01:07:27.134986Z","end":"2026-01-28T01:07:27.362207Z","steps":["trace[1073846762] 'agreement among raft nodes before linearized reading'  (duration: 227.109394ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:07:27.363128Z","caller":"traceutil/trace.go:171","msg":"trace[1854075989] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"335.237277ms","start":"2026-01-28T01:07:27.027879Z","end":"2026-01-28T01:07:27.363117Z","steps":["trace[1854075989] 'process raft request'  (duration: 332.271234ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:07:27.363225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:07:27.02786Z","time spent":"335.306849ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:693 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-01-28T01:08:31.237646Z","caller":"traceutil/trace.go:171","msg":"trace[465959687] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"185.0142ms","start":"2026-01-28T01:08:31.052613Z","end":"2026-01-28T01:08:31.237627Z","steps":["trace[465959687] 'process raft request'  (duration: 184.899058ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:08:31.278435Z","caller":"traceutil/trace.go:171","msg":"trace[8308670] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"103.683863ms","start":"2026-01-28T01:08:31.174735Z","end":"2026-01-28T01:08:31.278419Z","steps":["trace[8308670] 'read index received'  (duration: 63.101686ms)","trace[8308670] 'applied index is now lower than readState.Index'  (duration: 40.581207ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-28T01:08:31.278727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.976088ms","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-01-28T01:08:31.278783Z","caller":"traceutil/trace.go:171","msg":"trace[157277708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1001; }","duration":"104.09834ms","start":"2026-01-28T01:08:31.174674Z","end":"2026-01-28T01:08:31.278773Z","steps":["trace[157277708] 'agreement among raft nodes before linearized reading'  (duration: 103.919418ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:08:31.279028Z","caller":"traceutil/trace.go:171","msg":"trace[1482986761] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"226.338809ms","start":"2026-01-28T01:08:31.052664Z","end":"2026-01-28T01:08:31.279003Z","steps":["trace[1482986761] 'process raft request'  (duration: 225.679448ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:08:31.280036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.643842ms","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-01-28T01:08:31.280072Z","caller":"traceutil/trace.go:171","msg":"trace[254940704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1001; }","duration":"103.702233ms","start":"2026-01-28T01:08:31.17636Z","end":"2026-01-28T01:08:31.280062Z","steps":["trace[254940704] 'agreement among raft nodes before linearized reading'  (duration: 103.596311ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:08:31.443398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.576447ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939132357081469380 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:993 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-28T01:08:31.44367Z","caller":"traceutil/trace.go:171","msg":"trace[1757367007] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"157.936781ms","start":"2026-01-28T01:08:31.285712Z","end":"2026-01-28T01:08:31.443649Z","steps":["trace[1757367007] 'process raft request'  (duration: 52.987329ms)","trace[1757367007] 'compare'  (duration: 104.371784ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:08:33.360611Z","caller":"traceutil/trace.go:171","msg":"trace[853558089] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"114.853697ms","start":"2026-01-28T01:08:33.245734Z","end":"2026-01-28T01:08:33.360588Z","steps":["trace[853558089] 'process raft request'  (duration: 114.697235ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:08:34.345076Z","caller":"traceutil/trace.go:171","msg":"trace[400677146] linearizableReadLoop","detail":"{readStateIndex:1050; appliedIndex:1049; }","duration":"318.323782ms","start":"2026-01-28T01:08:34.026733Z","end":"2026-01-28T01:08:34.345056Z","steps":["trace[400677146] 'read index received'  (duration: 318.077698ms)","trace[400677146] 'applied index is now lower than readState.Index'  (duration: 245.164µs)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:08:34.345575Z","caller":"traceutil/trace.go:171","msg":"trace[880753328] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"459.603621ms","start":"2026-01-28T01:08:33.885955Z","end":"2026-01-28T01:08:34.345558Z","steps":["trace[880753328] 'process raft request'  (duration: 458.908401ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:08:34.347009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:08:33.885943Z","time spent":"461.008653ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1004 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-28T01:08:34.345711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.965101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.70\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-01-28T01:08:34.345948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.875563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-28T01:08:34.349597Z","caller":"traceutil/trace.go:171","msg":"trace[717931397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1011; }","duration":"213.561429ms","start":"2026-01-28T01:08:34.136028Z","end":"2026-01-28T01:08:34.34959Z","steps":["trace[717931397] 'agreement among raft nodes before linearized reading'  (duration: 209.890684ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:08:34.34951Z","caller":"traceutil/trace.go:171","msg":"trace[428379535] range","detail":"{range_begin:/registry/masterleases/162.253.55.70; range_end:; response_count:1; response_revision:1011; }","duration":"322.812651ms","start":"2026-01-28T01:08:34.026688Z","end":"2026-01-28T01:08:34.3495Z","steps":["trace[428379535] 'agreement among raft nodes before linearized reading'  (duration: 318.927421ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:08:34.350176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T01:08:34.026668Z","time spent":"323.495411ms","remote":"127.0.0.1:38172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/162.253.55.70\" "}
{"level":"warn","ts":"2026-01-28T01:08:35.481063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.400572ms","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-01-28T01:08:35.481215Z","caller":"traceutil/trace.go:171","msg":"trace[1866867270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1016; }","duration":"116.601165ms","start":"2026-01-28T01:08:35.364603Z","end":"2026-01-28T01:08:35.481204Z","steps":["trace[1866867270] 'range keys from in-memory index tree'  (duration: 116.28833ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:08:57.889573Z","caller":"traceutil/trace.go:171","msg":"trace[2070449809] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"150.164903ms","start":"2026-01-28T01:08:57.739389Z","end":"2026-01-28T01:08:57.889554Z","steps":["trace[2070449809] 'process raft request'  (duration: 83.546313ms)","trace[2070449809] 'compare'  (duration: 66.542969ms)"],"step_count":2}
{"level":"info","ts":"2026-01-28T01:08:57.897387Z","caller":"traceutil/trace.go:171","msg":"trace[292244276] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"157.742777ms","start":"2026-01-28T01:08:57.739617Z","end":"2026-01-28T01:08:57.897359Z","steps":["trace[292244276] 'process raft request'  (duration: 157.26883ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:08:57.897787Z","caller":"traceutil/trace.go:171","msg":"trace[615938769] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"153.868623ms","start":"2026-01-28T01:08:57.743904Z","end":"2026-01-28T01:08:57.897772Z","steps":["trace[615938769] 'process raft request'  (duration: 153.099533ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-28T01:08:57.89824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.016698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7036"}
{"level":"info","ts":"2026-01-28T01:08:57.898287Z","caller":"traceutil/trace.go:171","msg":"trace[624716397] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:1081; }","duration":"155.09114ms","start":"2026-01-28T01:08:57.743185Z","end":"2026-01-28T01:08:57.898276Z","steps":["trace[624716397] 'agreement among raft nodes before linearized reading'  (duration: 154.991669ms)"],"step_count":1}
{"level":"info","ts":"2026-01-28T01:08:57.897131Z","caller":"traceutil/trace.go:171","msg":"trace[1757046648] linearizableReadLoop","detail":"{readStateIndex:1124; appliedIndex:1122; }","duration":"153.904953ms","start":"2026-01-28T01:08:57.743205Z","end":"2026-01-28T01:08:57.89711Z","steps":["trace[1757046648] 'read index received'  (duration: 79.73691ms)","trace[1757046648] 'applied index is now lower than readState.Index'  (duration: 74.167133ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-28T01:08:57.90064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.820966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6684"}
{"level":"info","ts":"2026-01-28T01:08:57.900719Z","caller":"traceutil/trace.go:171","msg":"trace[803309018] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:1081; }","duration":"154.909867ms","start":"2026-01-28T01:08:57.745795Z","end":"2026-01-28T01:08:57.900705Z","steps":["trace[803309018] 'agreement among raft nodes before linearized reading'  (duration: 154.744655ms)"],"step_count":1}