{"level":"warn","ts":"2026-01-29T19:00:36.578589Z","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-29T19:00:36.578669Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43: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.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43: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-29T19:00:36.578727Z","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-29T19:00:36.578739Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]}
{"level":"info","ts":"2026-01-29T19:00:36.578758Z","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-29T19:00:36.579384Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]}
{"level":"info","ts":"2026-01-29T19:00:36.579451Z","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.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43: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-29T19:00:36.592122Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"12.487838ms"}
{"level":"info","ts":"2026-01-29T19:00:36.647814Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"}
{"level":"info","ts":"2026-01-29T19:00:36.647889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"}
{"level":"info","ts":"2026-01-29T19:00:36.647907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"}
{"level":"info","ts":"2026-01-29T19:00:36.64792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-29T19:00:36.647926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"}
{"level":"info","ts":"2026-01-29T19:00:36.647952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"}
{"level":"warn","ts":"2026-01-29T19:00:36.703875Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-29T19:00:36.721379Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-29T19:00:36.926862Z","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-29T19:00:36.961567Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-29T19:00:36.971935Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-29T19:00:36.97203Z","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-29T19:00:36.972055Z","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-29T19:00:36.972063Z","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-29T19:00:36.973671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"}
{"level":"info","ts":"2026-01-29T19:00:36.973731Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]}
{"level":"info","ts":"2026-01-29T19:00:36.9765Z","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-29T19:00:36.976613Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"}
{"level":"info","ts":"2026-01-29T19:00:36.981632Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"}
{"level":"info","ts":"2026-01-29T19:00:36.994509Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-29T19:00:36.994545Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-29T19:00:37.748517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"}
{"level":"info","ts":"2026-01-29T19:00:37.748599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-29T19:00:37.748646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"}
{"level":"info","ts":"2026-01-29T19:00:37.748673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"}
{"level":"info","ts":"2026-01-29T19:00:37.748689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"}
{"level":"info","ts":"2026-01-29T19:00:37.748711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"}
{"level":"info","ts":"2026-01-29T19:00:37.748724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"}
{"level":"info","ts":"2026-01-29T19:00:37.794117Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T19:00:37.795587Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-29T19:00:37.795746Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-29T19:00:37.795876Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-29T19:00:37.795929Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-29T19:00:37.796006Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-29T19:00:37.800211Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"}
{"level":"info","ts":"2026-01-29T19:00:37.801297Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-29T19:00:37.814934Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T19:00:37.815004Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-29T19:00:37.815024Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-01-29T19:00:40.003227Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349190424569977,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:00:40.503637Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349190424569977,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:00:41.004387Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349190424569977,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-29T19:00:41.152902Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.659914134s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-29T19:00:41.153819Z","caller":"traceutil/trace.go:171","msg":"trace[2002424010] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"1.660824153s","start":"2026-01-29T19:00:39.492944Z","end":"2026-01-29T19:00:41.153768Z","steps":["trace[2002424010] 'process raft request'  (duration: 1.660608011s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:41.154693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.492933Z","time spent":"1.661004705s","remote":"127.0.0.1:42224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/ranges/servicenodeports\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/servicenodeports\" value_size:66 >> failure:<request_range:<key:\"/registry/ranges/servicenodeports\" > >"}
{"level":"warn","ts":"2026-01-29T19:00:42.194918Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.0418042s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-29T19:00:42.195556Z","caller":"traceutil/trace.go:171","msg":"trace[1629659734] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"2.701784725s","start":"2026-01-29T19:00:39.493747Z","end":"2026-01-29T19:00:42.195532Z","steps":["trace[1629659734] 'process raft request'  (duration: 2.701340631s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.195653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.693431663s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.195692Z","caller":"traceutil/trace.go:171","msg":"trace[1623412386] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"2.693496113s","start":"2026-01-29T19:00:39.502187Z","end":"2026-01-29T19:00:42.195684Z","steps":["trace[1623412386] 'agreement among raft nodes before linearized reading'  (duration: 2.693402942s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.195721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.502182Z","time spent":"2.693531494s","remote":"127.0.0.1:42582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-01-29T19:00:42.195755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.493736Z","time spent":"2.701863695s","remote":"127.0.0.1:42218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:67 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"info","ts":"2026-01-29T19:00:42.195886Z","caller":"traceutil/trace.go:171","msg":"trace[433693403] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"2.681776486s","start":"2026-01-29T19:00:39.5141Z","end":"2026-01-29T19:00:42.195877Z","steps":["trace[433693403] 'process raft request'  (duration: 2.681209481s)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.195561Z","caller":"traceutil/trace.go:171","msg":"trace[133252873] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:4; }","duration":"2.693339612s","start":"2026-01-29T19:00:39.502206Z","end":"2026-01-29T19:00:42.195546Z","steps":["trace[133252873] 'read index received'  (duration: 1.651120338s)","trace[133252873] 'applied index is now lower than readState.Index'  (duration: 1.042218474s)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:00:42.195934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.514088Z","time spent":"2.681819936s","remote":"127.0.0.1:42718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"warn","ts":"2026-01-29T19:00:42.196055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.647783311s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.19609Z","caller":"traceutil/trace.go:171","msg":"trace[328418073] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.647851341s","start":"2026-01-29T19:00:39.548226Z","end":"2026-01-29T19:00:42.196077Z","steps":["trace[328418073] 'agreement among raft nodes before linearized reading'  (duration: 2.64780062s)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.196086Z","caller":"traceutil/trace.go:171","msg":"trace[470245177] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"2.681667595s","start":"2026-01-29T19:00:39.514409Z","end":"2026-01-29T19:00:42.196076Z","steps":["trace[470245177] 'process raft request'  (duration: 2.680955198s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.196133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.548211Z","time spent":"2.647914111s","remote":"127.0.0.1:42272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-01-29T19:00:42.196152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.51439Z","time spent":"2.681740675s","remote":"127.0.0.1:42718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"info","ts":"2026-01-29T19:00:42.196271Z","caller":"traceutil/trace.go:171","msg":"trace[1545687133] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"2.681614705s","start":"2026-01-29T19:00:39.514645Z","end":"2026-01-29T19:00:42.19626Z","steps":["trace[1545687133] 'process raft request'  (duration: 2.680745987s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.196294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.325015366s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-01-29T19:00:42.196311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.514639Z","time spent":"2.681653455s","remote":"127.0.0.1:42718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"info","ts":"2026-01-29T19:00:42.196321Z","caller":"traceutil/trace.go:171","msg":"trace[2070150854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"1.325084176s","start":"2026-01-29T19:00:40.871228Z","end":"2026-01-29T19:00:42.196313Z","steps":["trace[2070150854] 'agreement among raft nodes before linearized reading'  (duration: 1.325046146s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.196345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:40.871213Z","time spent":"1.325126367s","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-01-29T19:00:42.19642Z","caller":"traceutil/trace.go:171","msg":"trace[1556449049] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"2.681485803s","start":"2026-01-29T19:00:39.514926Z","end":"2026-01-29T19:00:42.196412Z","steps":["trace[1556449049] 'process raft request'  (duration: 2.680490264s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.196463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.815299011s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.196488Z","caller":"traceutil/trace.go:171","msg":"trace[1070736174] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"2.680366463s","start":"2026-01-29T19:00:39.516116Z","end":"2026-01-29T19:00:42.196482Z","steps":["trace[1070736174] 'process raft request'  (duration: 2.679323663s)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.196489Z","caller":"traceutil/trace.go:171","msg":"trace[1867293561] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11; }","duration":"1.815336742s","start":"2026-01-29T19:00:40.381144Z","end":"2026-01-29T19:00:42.196481Z","steps":["trace[1867293561] 'agreement among raft nodes before linearized reading'  (duration: 1.815298631s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.196663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.516103Z","time spent":"2.680402323s","remote":"127.0.0.1:42718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"info","ts":"2026-01-29T19:00:42.196888Z","caller":"traceutil/trace.go:171","msg":"trace[918374859] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"2.659038471s","start":"2026-01-29T19:00:39.537839Z","end":"2026-01-29T19:00:42.196878Z","steps":["trace[918374859] 'process raft request'  (duration: 2.657625688s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.196931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.537799Z","time spent":"2.659112263s","remote":"127.0.0.1:42348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2846,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:2812 >> failure:<>"}
{"level":"info","ts":"2026-01-29T19:00:42.197132Z","caller":"traceutil/trace.go:171","msg":"trace[1568161231] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"2.613962976s","start":"2026-01-29T19:00:39.583159Z","end":"2026-01-29T19:00:42.197122Z","steps":["trace[1568161231] 'process raft request'  (duration: 2.61233305s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.197174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.583135Z","time spent":"2.614019617s","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"info","ts":"2026-01-29T19:00:42.197328Z","caller":"traceutil/trace.go:171","msg":"trace[521663743] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.115611885s","start":"2026-01-29T19:00:41.081708Z","end":"2026-01-29T19:00:42.19732Z","steps":["trace[521663743] 'process raft request'  (duration: 1.113812498s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.19737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:41.081691Z","time spent":"1.115661686s","remote":"127.0.0.1:42442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-v5bfh\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-v5bfh\" value_size:795 >> failure:<>"}
{"level":"warn","ts":"2026-01-29T19:00:42.197884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.618289969s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.197906Z","caller":"traceutil/trace.go:171","msg":"trace[181391602] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.61831224s","start":"2026-01-29T19:00:39.579586Z","end":"2026-01-29T19:00:42.197899Z","steps":["trace[181391602] 'agreement among raft nodes before linearized reading'  (duration: 2.618280049s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.197922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.579575Z","time spent":"2.61834352s","remote":"127.0.0.1:42272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-01-29T19:00:42.197997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.818443932s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.198013Z","caller":"traceutil/trace.go:171","msg":"trace[388184312] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:11; }","duration":"1.818518673s","start":"2026-01-29T19:00:40.379489Z","end":"2026-01-29T19:00:42.198008Z","steps":["trace[388184312] 'agreement among raft nodes before linearized reading'  (duration: 1.818494422s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.198028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:40.379473Z","time spent":"1.818551283s","remote":"127.0.0.1:42568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "}
{"level":"warn","ts":"2026-01-29T19:00:42.1981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.566241004s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.198115Z","caller":"traceutil/trace.go:171","msg":"trace[1285017484] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.566301605s","start":"2026-01-29T19:00:39.631809Z","end":"2026-01-29T19:00:42.198111Z","steps":["trace[1285017484] 'agreement among raft nodes before linearized reading'  (duration: 2.566279564s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.19813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.631789Z","time spent":"2.566337955s","remote":"127.0.0.1:42272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-01-29T19:00:42.198199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.614901075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.198215Z","caller":"traceutil/trace.go:171","msg":"trace[106328325] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"2.614917056s","start":"2026-01-29T19:00:39.583293Z","end":"2026-01-29T19:00:42.19821Z","steps":["trace[106328325] 'agreement among raft nodes before linearized reading'  (duration: 2.614894585s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.198232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.583252Z","time spent":"2.614975667s","remote":"127.0.0.1:42246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-01-29T19:00:42.198302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.616397049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.198317Z","caller":"traceutil/trace.go:171","msg":"trace[1897188970] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:0; response_revision:11; }","duration":"2.616411389s","start":"2026-01-29T19:00:39.581901Z","end":"2026-01-29T19:00:42.198312Z","steps":["trace[1897188970] 'agreement among raft nodes before linearized reading'  (duration: 2.616390369s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.198333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.581858Z","time spent":"2.616470501s","remote":"127.0.0.1:42172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/162.253.55.43\" "}
{"level":"warn","ts":"2026-01-29T19:00:42.198636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.649126913s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.198658Z","caller":"traceutil/trace.go:171","msg":"trace[608919323] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.649159454s","start":"2026-01-29T19:00:39.54949Z","end":"2026-01-29T19:00:42.198649Z","steps":["trace[608919323] 'agreement among raft nodes before linearized reading'  (duration: 2.649133513s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.198674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.549483Z","time spent":"2.649187334s","remote":"127.0.0.1:42272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-01-29T19:00:42.198741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.649372195s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.198758Z","caller":"traceutil/trace.go:171","msg":"trace[1916904270] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"2.649420447s","start":"2026-01-29T19:00:39.549333Z","end":"2026-01-29T19:00:42.198754Z","steps":["trace[1916904270] 'agreement among raft nodes before linearized reading'  (duration: 2.649395546s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.198773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.549323Z","time spent":"2.649446577s","remote":"127.0.0.1:42272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-01-29T19:00:42.196462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:39.51492Z","time spent":"2.681521243s","remote":"127.0.0.1:42718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"warn","ts":"2026-01-29T19:00:42.207033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:00:40.381119Z","time spent":"1.815389892s","remote":"127.0.0.1:42546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "}
{"level":"info","ts":"2026-01-29T19:00:42.365092Z","caller":"traceutil/trace.go:171","msg":"trace[1355919949] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"147.957308ms","start":"2026-01-29T19:00:42.217108Z","end":"2026-01-29T19:00:42.365065Z","steps":["trace[1355919949] 'process raft request'  (duration: 113.240486ms)","trace[1355919949] 'compare'  (duration: 34.307488ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:00:42.365568Z","caller":"traceutil/trace.go:171","msg":"trace[2078909282] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"146.92242ms","start":"2026-01-29T19:00:42.218634Z","end":"2026-01-29T19:00:42.365556Z","steps":["trace[2078909282] 'process raft request'  (duration: 146.244083ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.365745Z","caller":"traceutil/trace.go:171","msg":"trace[415003299] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"146.96199ms","start":"2026-01-29T19:00:42.218772Z","end":"2026-01-29T19:00:42.365734Z","steps":["trace[415003299] 'process raft request'  (duration: 146.130872ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.36593Z","caller":"traceutil/trace.go:171","msg":"trace[835050512] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"148.415084ms","start":"2026-01-29T19:00:42.217166Z","end":"2026-01-29T19:00:42.365581Z","steps":["trace[835050512] 'process raft request'  (duration: 147.542465ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.366158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.923638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3178"}
{"level":"info","ts":"2026-01-29T19:00:42.366197Z","caller":"traceutil/trace.go:171","msg":"trace[1809422138] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"149.005719ms","start":"2026-01-29T19:00:42.217183Z","end":"2026-01-29T19:00:42.366188Z","steps":["trace[1809422138] 'agreement among raft nodes before linearized reading'  (duration: 148.829697ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.366404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.321091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.366433Z","caller":"traceutil/trace.go:171","msg":"trace[1377756988] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:20; }","duration":"149.376183ms","start":"2026-01-29T19:00:42.217051Z","end":"2026-01-29T19:00:42.366427Z","steps":["trace[1377756988] 'agreement among raft nodes before linearized reading'  (duration: 149.329392ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.366636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.822328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.366662Z","caller":"traceutil/trace.go:171","msg":"trace[1748571384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"149.849728ms","start":"2026-01-29T19:00:42.216807Z","end":"2026-01-29T19:00:42.366657Z","steps":["trace[1748571384] 'agreement among raft nodes before linearized reading'  (duration: 149.809267ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.367515Z","caller":"traceutil/trace.go:171","msg":"trace[660543614] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"150.288561ms","start":"2026-01-29T19:00:42.217219Z","end":"2026-01-29T19:00:42.367507Z","steps":["trace[660543614] 'process raft request'  (duration: 147.549075ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.367703Z","caller":"traceutil/trace.go:171","msg":"trace[739286644] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"149.895527ms","start":"2026-01-29T19:00:42.217797Z","end":"2026-01-29T19:00:42.367692Z","steps":["trace[739286644] 'process raft request'  (duration: 147.01652ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.368001Z","caller":"traceutil/trace.go:171","msg":"trace[1507523620] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"150.27204ms","start":"2026-01-29T19:00:42.217722Z","end":"2026-01-29T19:00:42.367994Z","steps":["trace[1507523620] 'process raft request'  (duration: 147.12367ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.365964Z","caller":"traceutil/trace.go:171","msg":"trace[1513747625] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"147.132611ms","start":"2026-01-29T19:00:42.218804Z","end":"2026-01-29T19:00:42.365937Z","steps":["trace[1513747625] 'process raft request'  (duration: 146.129851ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.366Z","caller":"traceutil/trace.go:171","msg":"trace[66942230] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"147.089552ms","start":"2026-01-29T19:00:42.218903Z","end":"2026-01-29T19:00:42.365993Z","steps":["trace[66942230] 'process raft request'  (duration: 146.061481ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.622241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.666942ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16995349190424570018 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.networking.k8s.io\" value_size:886 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-01-29T19:00:42.622671Z","caller":"traceutil/trace.go:171","msg":"trace[467382916] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"216.341285ms","start":"2026-01-29T19:00:42.406307Z","end":"2026-01-29T19:00:42.622648Z","steps":["trace[467382916] 'process raft request'  (duration: 82.722564ms)","trace[467382916] 'compare'  (duration: 132.386209ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:00:42.623197Z","caller":"traceutil/trace.go:171","msg":"trace[1882681707] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"216.888571ms","start":"2026-01-29T19:00:42.406297Z","end":"2026-01-29T19:00:42.623186Z","steps":["trace[1882681707] 'process raft request'  (duration: 216.060132ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.623488Z","caller":"traceutil/trace.go:171","msg":"trace[2073712515] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"216.999023ms","start":"2026-01-29T19:00:42.406471Z","end":"2026-01-29T19:00:42.62347Z","steps":["trace[2073712515] 'process raft request'  (duration: 215.973482ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.623849Z","caller":"traceutil/trace.go:171","msg":"trace[909752373] linearizableReadLoop","detail":"{readStateIndex:38; appliedIndex:35; }","duration":"189.429817ms","start":"2026-01-29T19:00:42.434408Z","end":"2026-01-29T19:00:42.623838Z","steps":["trace[909752373] 'read index received'  (duration: 54.582914ms)","trace[909752373] 'applied index is now lower than readState.Index'  (duration: 134.845643ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:00:42.624003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.409088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.624275Z","caller":"traceutil/trace.go:171","msg":"trace[1409551257] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:34; }","duration":"210.705222ms","start":"2026-01-29T19:00:42.413514Z","end":"2026-01-29T19:00:42.624219Z","steps":["trace[1409551257] 'agreement among raft nodes before linearized reading'  (duration: 210.385509ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.624053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.117493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.624733Z","caller":"traceutil/trace.go:171","msg":"trace[1021761083] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:34; }","duration":"218.816309ms","start":"2026-01-29T19:00:42.405904Z","end":"2026-01-29T19:00:42.62472Z","steps":["trace[1021761083] 'agreement among raft nodes before linearized reading'  (duration: 218.131543ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.635252Z","caller":"traceutil/trace.go:171","msg":"trace[242602906] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"193.440685ms","start":"2026-01-29T19:00:42.441797Z","end":"2026-01-29T19:00:42.635238Z","steps":["trace[242602906] 'process raft request'  (duration: 193.215793ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.635548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.221724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.635725Z","caller":"traceutil/trace.go:171","msg":"trace[17925087] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:38; }","duration":"193.398735ms","start":"2026-01-29T19:00:42.442276Z","end":"2026-01-29T19:00:42.635675Z","steps":["trace[17925087] 'agreement among raft nodes before linearized reading'  (duration: 193.167823ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.635867Z","caller":"traceutil/trace.go:171","msg":"trace[516485276] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"193.500896ms","start":"2026-01-29T19:00:42.442355Z","end":"2026-01-29T19:00:42.635856Z","steps":["trace[516485276] 'process raft request'  (duration: 192.756039ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.636173Z","caller":"traceutil/trace.go:171","msg":"trace[1145212409] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"193.426876ms","start":"2026-01-29T19:00:42.442736Z","end":"2026-01-29T19:00:42.636163Z","steps":["trace[1145212409] 'process raft request'  (duration: 192.527087ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.637524Z","caller":"traceutil/trace.go:171","msg":"trace[789009621] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"195.049861ms","start":"2026-01-29T19:00:42.44246Z","end":"2026-01-29T19:00:42.63751Z","steps":["trace[789009621] 'process raft request'  (duration: 192.689928ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.808755Z","caller":"traceutil/trace.go:171","msg":"trace[1067778348] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"179.2934ms","start":"2026-01-29T19:00:42.629441Z","end":"2026-01-29T19:00:42.808734Z","steps":["trace[1067778348] 'process raft request'  (duration: 179.258889ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.809178Z","caller":"traceutil/trace.go:171","msg":"trace[164442937] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"179.959467ms","start":"2026-01-29T19:00:42.629193Z","end":"2026-01-29T19:00:42.809153Z","steps":["trace[164442937] 'process raft request'  (duration: 101.880157ms)","trace[164442937] 'compare'  (duration: 77.468954ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:00:42.809842Z","caller":"traceutil/trace.go:171","msg":"trace[1061851970] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"180.480771ms","start":"2026-01-29T19:00:42.62935Z","end":"2026-01-29T19:00:42.809831Z","steps":["trace[1061851970] 'process raft request'  (duration: 179.32193ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:42.837348Z","caller":"traceutil/trace.go:171","msg":"trace[1061326537] linearizableReadLoop","detail":"{readStateIndex:46; appliedIndex:42; }","duration":"196.601826ms","start":"2026-01-29T19:00:42.640728Z","end":"2026-01-29T19:00:42.837329Z","steps":["trace[1061326537] 'read index received'  (duration: 90.358796ms)","trace[1061326537] 'applied index is now lower than readState.Index'  (duration: 106.24206ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:00:42.83765Z","caller":"traceutil/trace.go:171","msg":"trace[1584239085] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"197.278012ms","start":"2026-01-29T19:00:42.64036Z","end":"2026-01-29T19:00:42.837638Z","steps":["trace[1584239085] 'process raft request'  (duration: 196.873088ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:42.837934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.228671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:42.837972Z","caller":"traceutil/trace.go:171","msg":"trace[734127928] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:42; }","duration":"197.303473ms","start":"2026-01-29T19:00:42.640659Z","end":"2026-01-29T19:00:42.837963Z","steps":["trace[734127928] 'agreement among raft nodes before linearized reading'  (duration: 197.239712ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:43.014922Z","caller":"traceutil/trace.go:171","msg":"trace[928013006] linearizableReadLoop","detail":"{readStateIndex:54; appliedIndex:52; }","duration":"108.354387ms","start":"2026-01-29T19:00:42.906545Z","end":"2026-01-29T19:00:43.0149Z","steps":["trace[928013006] 'read index received'  (duration: 8.426761ms)","trace[928013006] 'applied index is now lower than readState.Index'  (duration: 99.926536ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:00:43.015286Z","caller":"traceutil/trace.go:171","msg":"trace[1728922581] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"115.108363ms","start":"2026-01-29T19:00:42.900135Z","end":"2026-01-29T19:00:43.015243Z","steps":["trace[1728922581] 'process raft request'  (duration: 14.842324ms)","trace[1728922581] 'compare'  (duration: 99.723724ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:00:43.015307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.736611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/system-nodes\" ","response":"range_response_count:1 size:1070"}
{"level":"info","ts":"2026-01-29T19:00:43.015557Z","caller":"traceutil/trace.go:171","msg":"trace[1574641077] range","detail":"{range_begin:/registry/flowschemas/system-nodes; range_end:; response_count:1; response_revision:50; }","duration":"109.033365ms","start":"2026-01-29T19:00:42.906514Z","end":"2026-01-29T19:00:43.015547Z","steps":["trace[1574641077] 'agreement among raft nodes before linearized reading'  (duration: 108.476699ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:43.015796Z","caller":"traceutil/trace.go:171","msg":"trace[1830462403] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"115.478247ms","start":"2026-01-29T19:00:42.9003Z","end":"2026-01-29T19:00:43.015778Z","steps":["trace[1830462403] 'process raft request'  (duration: 114.553748ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:43.241412Z","caller":"traceutil/trace.go:171","msg":"trace[1283462003] linearizableReadLoop","detail":"{readStateIndex:61; appliedIndex:59; }","duration":"136.83173ms","start":"2026-01-29T19:00:43.104558Z","end":"2026-01-29T19:00:43.241389Z","steps":["trace[1283462003] 'read index received'  (duration: 71.54742ms)","trace[1283462003] 'applied index is now lower than readState.Index'  (duration: 65.28351ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:00:43.241556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.995661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/system-leader-election\" ","response":"range_response_count:1 size:1228"}
{"level":"info","ts":"2026-01-29T19:00:43.241597Z","caller":"traceutil/trace.go:171","msg":"trace[1057613089] range","detail":"{range_begin:/registry/flowschemas/system-leader-election; range_end:; response_count:1; response_revision:57; }","duration":"137.068462ms","start":"2026-01-29T19:00:43.104516Z","end":"2026-01-29T19:00:43.241585Z","steps":["trace[1057613089] 'agreement among raft nodes before linearized reading'  (duration: 136.952081ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:43.241884Z","caller":"traceutil/trace.go:171","msg":"trace[1896457664] transaction","detail":"{read_only:false; response_revision:56; number_of_response:1; }","duration":"137.908209ms","start":"2026-01-29T19:00:43.103847Z","end":"2026-01-29T19:00:43.241755Z","steps":["trace[1896457664] 'process raft request'  (duration: 72.250406ms)","trace[1896457664] 'compare'  (duration: 65.143149ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:00:43.24191Z","caller":"traceutil/trace.go:171","msg":"trace[1358613977] transaction","detail":"{read_only:false; response_revision:57; number_of_response:1; }","duration":"137.637268ms","start":"2026-01-29T19:00:43.104261Z","end":"2026-01-29T19:00:43.241899Z","steps":["trace[1358613977] 'process raft request'  (duration: 137.089153ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:43.483106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.783585ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16995349190424570063 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/flowschemas/kube-controller-manager\" mod_revision:56 > success:<request_put:<key:\"/registry/flowschemas/kube-controller-manager\" value_size:1063 >> failure:<request_range:<key:\"/registry/flowschemas/kube-controller-manager\" > >>","response":"size:14"}
{"level":"info","ts":"2026-01-29T19:00:43.483325Z","caller":"traceutil/trace.go:171","msg":"trace[629780524] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"205.637444ms","start":"2026-01-29T19:00:43.277667Z","end":"2026-01-29T19:00:43.483304Z","steps":["trace[629780524] 'process raft request'  (duration: 102.585625ms)","trace[629780524] 'compare'  (duration: 102.531023ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:00:43.483528Z","caller":"traceutil/trace.go:171","msg":"trace[1904126177] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"165.042038ms","start":"2026-01-29T19:00:43.318194Z","end":"2026-01-29T19:00:43.483236Z","steps":["trace[1904126177] 'process raft request'  (duration: 164.996058ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:00:43.483831Z","caller":"traceutil/trace.go:171","msg":"trace[931721257] linearizableReadLoop","detail":"{readStateIndex:67; appliedIndex:64; }","duration":"200.494085ms","start":"2026-01-29T19:00:43.283325Z","end":"2026-01-29T19:00:43.483819Z","steps":["trace[931721257] 'read index received'  (duration: 32.223806ms)","trace[931721257] 'applied index is now lower than readState.Index'  (duration: 168.269039ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:00:43.484125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.789787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:43.484166Z","caller":"traceutil/trace.go:171","msg":"trace[381275565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:64; }","duration":"200.833528ms","start":"2026-01-29T19:00:43.283322Z","end":"2026-01-29T19:00:43.484156Z","steps":["trace[381275565] 'agreement among raft nodes before linearized reading'  (duration: 200.739837ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:00:43.484639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.874836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:public-info-viewer\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-01-29T19:00:43.484744Z","caller":"traceutil/trace.go:171","msg":"trace[1180906626] range","detail":"{range_begin:/registry/clusterroles/system:public-info-viewer; range_end:; response_count:0; response_revision:64; }","duration":"167.001147ms","start":"2026-01-29T19:00:43.31773Z","end":"2026-01-29T19:00:43.484731Z","steps":["trace[1180906626] 'agreement among raft nodes before linearized reading'  (duration: 166.790705ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:00.731259Z","caller":"traceutil/trace.go:171","msg":"trace[1273809572] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"112.433687ms","start":"2026-01-29T19:01:00.618802Z","end":"2026-01-29T19:01:00.731235Z","steps":["trace[1273809572] 'process raft request'  (duration: 112.220145ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:08.881571Z","caller":"traceutil/trace.go:171","msg":"trace[631492900] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"141.162993ms","start":"2026-01-29T19:01:08.740386Z","end":"2026-01-29T19:01:08.881549Z","steps":["trace[631492900] 'process raft request'  (duration: 140.868411ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:08.891212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.800314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:08.891576Z","caller":"traceutil/trace.go:171","msg":"trace[604590983] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:469; }","duration":"149.180328ms","start":"2026-01-29T19:01:08.742372Z","end":"2026-01-29T19:01:08.891552Z","steps":["trace[604590983] 'agreement among raft nodes before linearized reading'  (duration: 148.755373ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:08.891083Z","caller":"traceutil/trace.go:171","msg":"trace[1939475601] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:485; }","duration":"148.669903ms","start":"2026-01-29T19:01:08.74239Z","end":"2026-01-29T19:01:08.89106Z","steps":["trace[1939475601] 'read index received'  (duration: 146.225674ms)","trace[1939475601] 'applied index is now lower than readState.Index'  (duration: 2.442469ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:01:08.894139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.768719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-29T19:01:08.894222Z","caller":"traceutil/trace.go:171","msg":"trace[252953038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:469; }","duration":"121.87697ms","start":"2026-01-29T19:01:08.772338Z","end":"2026-01-29T19:01:08.894215Z","steps":["trace[252953038] 'agreement among raft nodes before linearized reading'  (duration: 121.448476ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:09.06909Z","caller":"traceutil/trace.go:171","msg":"trace[884208777] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"159.203485ms","start":"2026-01-29T19:01:08.909868Z","end":"2026-01-29T19:01:09.069071Z","steps":["trace[884208777] 'process raft request'  (duration: 159.166775ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:09.069496Z","caller":"traceutil/trace.go:171","msg":"trace[824238003] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"168.987852ms","start":"2026-01-29T19:01:08.900495Z","end":"2026-01-29T19:01:09.069483Z","steps":["trace[824238003] 'process raft request'  (duration: 92.580746ms)","trace[824238003] 'compare'  (duration: 75.451349ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:09.069546Z","caller":"traceutil/trace.go:171","msg":"trace[641685382] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"159.72313ms","start":"2026-01-29T19:01:08.9098Z","end":"2026-01-29T19:01:09.069523Z","steps":["trace[641685382] 'process raft request'  (duration: 159.176595ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:09.236264Z","caller":"traceutil/trace.go:171","msg":"trace[1257318282] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"104.457047ms","start":"2026-01-29T19:01:09.131786Z","end":"2026-01-29T19:01:09.236243Z","steps":["trace[1257318282] 'process raft request'  (duration: 104.416717ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:09.236767Z","caller":"traceutil/trace.go:171","msg":"trace[1455536608] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"105.869748ms","start":"2026-01-29T19:01:09.130873Z","end":"2026-01-29T19:01:09.236743Z","steps":["trace[1455536608] 'process raft request'  (duration: 61.255325ms)","trace[1455536608] 'compare'  (duration: 43.929028ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:12.026469Z","caller":"traceutil/trace.go:171","msg":"trace[663078413] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"367.281539ms","start":"2026-01-29T19:01:11.659168Z","end":"2026-01-29T19:01:12.026449Z","steps":["trace[663078413] 'process raft request'  (duration: 366.881726ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:12.026588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:11.659155Z","time spent":"367.37402ms","remote":"127.0.0.1:42448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:497 > 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-01-29T19:01:12.828653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.21623ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16995349190424570960 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:504 > 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-29T19:01:12.82881Z","caller":"traceutil/trace.go:171","msg":"trace[1964644184] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"796.681079ms","start":"2026-01-29T19:01:12.032106Z","end":"2026-01-29T19:01:12.828787Z","steps":["trace[1964644184] 'process raft request'  (duration: 239.233857ms)","trace[1964644184] 'compare'  (duration: 557.132649ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:01:12.828911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:12.032087Z","time spent":"796.768599ms","remote":"127.0.0.1:42448","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:504 > 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":"warn","ts":"2026-01-29T19:01:14.250082Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349190424570965,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-29T19:01:14.439264Z","caller":"traceutil/trace.go:171","msg":"trace[1444698421] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"983.296346ms","start":"2026-01-29T19:01:13.455953Z","end":"2026-01-29T19:01:14.439249Z","steps":["trace[1444698421] 'process raft request'  (duration: 983.190935ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:14.439359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:13.455942Z","time spent":"983.369837ms","remote":"127.0.0.1:42448","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:509 > 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-29T19:01:14.457115Z","caller":"traceutil/trace.go:171","msg":"trace[1960730628] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:530; }","duration":"707.591232ms","start":"2026-01-29T19:01:13.749506Z","end":"2026-01-29T19:01:14.457097Z","steps":["trace[1960730628] 'read index received'  (duration: 690.099667ms)","trace[1960730628] 'applied index is now lower than readState.Index'  (duration: 17.490835ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:14.457238Z","caller":"traceutil/trace.go:171","msg":"trace[1722747629] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"810.883545ms","start":"2026-01-29T19:01:13.646347Z","end":"2026-01-29T19:01:14.457231Z","steps":["trace[1722747629] 'process raft request'  (duration: 808.779789ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:14.457441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.692198ms","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-29T19:01:14.457495Z","caller":"traceutil/trace.go:171","msg":"trace[499036723] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:514; }","duration":"427.773029ms","start":"2026-01-29T19:01:14.029707Z","end":"2026-01-29T19:01:14.45748Z","steps":["trace[499036723] 'agreement among raft nodes before linearized reading'  (duration: 427.642227ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:14.457535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:14.029696Z","time spent":"427.819201ms","remote":"127.0.0.1:42448","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-29T19:01:14.457649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.143527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:14.457667Z","caller":"traceutil/trace.go:171","msg":"trace[908095690] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"708.187557ms","start":"2026-01-29T19:01:13.749474Z","end":"2026-01-29T19:01:14.457661Z","steps":["trace[908095690] 'agreement among raft nodes before linearized reading'  (duration: 708.158587ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:14.45768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:13.749459Z","time spent":"708.218268ms","remote":"127.0.0.1:42126","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-01-29T19:01:14.457773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.873665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-01-29T19:01:14.457788Z","caller":"traceutil/trace.go:171","msg":"trace[1953541373] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:514; }","duration":"169.912975ms","start":"2026-01-29T19:01:14.28787Z","end":"2026-01-29T19:01:14.457783Z","steps":["trace[1953541373] 'agreement among raft nodes before linearized reading'  (duration: 169.881294ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:14.457324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:13.646325Z","time spent":"810.934915ms","remote":"127.0.0.1:42448","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:456 > 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-29T19:01:18.61077Z","caller":"traceutil/trace.go:171","msg":"trace[2023075230] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"137.703808ms","start":"2026-01-29T19:01:18.473052Z","end":"2026-01-29T19:01:18.610755Z","steps":["trace[2023075230] 'read index received'  (duration: 137.584897ms)","trace[2023075230] 'applied index is now lower than readState.Index'  (duration: 118.031µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:01:18.610894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.825919ms","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-29T19:01:18.610911Z","caller":"traceutil/trace.go:171","msg":"trace[201907940] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"137.868579ms","start":"2026-01-29T19:01:18.473037Z","end":"2026-01-29T19:01:18.610905Z","steps":["trace[201907940] 'agreement among raft nodes before linearized reading'  (duration: 137.777739ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:18.61107Z","caller":"traceutil/trace.go:171","msg":"trace[823628482] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"161.363667ms","start":"2026-01-29T19:01:18.449701Z","end":"2026-01-29T19:01:18.611065Z","steps":["trace[823628482] 'process raft request'  (duration: 160.973724ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:21.156569Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349190424571049,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-29T19:01:21.386154Z","caller":"traceutil/trace.go:171","msg":"trace[900358462] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"729.926674ms","start":"2026-01-29T19:01:20.656214Z","end":"2026-01-29T19:01:21.38614Z","steps":["trace[900358462] 'read index received'  (duration: 729.791929ms)","trace[900358462] 'applied index is now lower than readState.Index'  (duration: 132.635µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:21.386418Z","caller":"traceutil/trace.go:171","msg":"trace[1174103456] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"766.572108ms","start":"2026-01-29T19:01:20.619837Z","end":"2026-01-29T19:01:21.386409Z","steps":["trace[1174103456] 'process raft request'  (duration: 766.209105ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:21.386488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:20.619825Z","time spent":"766.61477ms","remote":"127.0.0.1:42448","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:546 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-01-29T19:01:21.386644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.430613ms","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-29T19:01:21.386665Z","caller":"traceutil/trace.go:171","msg":"trace[1344294427] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"730.492766ms","start":"2026-01-29T19:01:20.656165Z","end":"2026-01-29T19:01:21.386658Z","steps":["trace[1344294427] 'agreement among raft nodes before linearized reading'  (duration: 730.417953ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:21.386683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:20.656143Z","time spent":"730.534346ms","remote":"127.0.0.1:42448","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-29T19:01:21.386755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.059218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:21.386769Z","caller":"traceutil/trace.go:171","msg":"trace[1881229124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"643.10177ms","start":"2026-01-29T19:01:20.743662Z","end":"2026-01-29T19:01:21.386764Z","steps":["trace[1881229124] 'agreement among raft nodes before linearized reading'  (duration: 643.080589ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:21.386783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:20.743643Z","time spent":"643.136602ms","remote":"127.0.0.1:42126","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-01-29T19:01:21.386927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.357007ms","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-29T19:01:21.386942Z","caller":"traceutil/trace.go:171","msg":"trace[25680821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"189.373627ms","start":"2026-01-29T19:01:21.197564Z","end":"2026-01-29T19:01:21.386938Z","steps":["trace[25680821] 'agreement among raft nodes before linearized reading'  (duration: 189.311595ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:21.387031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.879875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-29T19:01:21.387048Z","caller":"traceutil/trace.go:171","msg":"trace[1460040476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:554; }","duration":"511.947497ms","start":"2026-01-29T19:01:20.875095Z","end":"2026-01-29T19:01:21.387042Z","steps":["trace[1460040476] 'agreement among raft nodes before linearized reading'  (duration: 511.899855ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:21.387068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:20.875074Z","time spent":"511.990569ms","remote":"127.0.0.1:42448","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-01-29T19:01:22.245112Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349190424571053,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-29T19:01:22.65591Z","caller":"traceutil/trace.go:171","msg":"trace[1994142284] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"1.263204617s","start":"2026-01-29T19:01:21.392689Z","end":"2026-01-29T19:01:22.655894Z","steps":["trace[1994142284] 'process raft request'  (duration: 1.251015837s)","trace[1994142284] 'compare'  (duration: 11.641899ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:01:22.655994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:21.392677Z","time spent":"1.26327382s","remote":"127.0.0.1:42448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:547 > 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":"info","ts":"2026-01-29T19:01:22.697497Z","caller":"traceutil/trace.go:171","msg":"trace[1295577196] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:573; }","duration":"953.346692ms","start":"2026-01-29T19:01:21.744122Z","end":"2026-01-29T19:01:22.697469Z","steps":["trace[1295577196] 'read index received'  (duration: 899.590145ms)","trace[1295577196] 'applied index is now lower than readState.Index'  (duration: 53.755747ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:01:22.697621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.495688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:22.69765Z","caller":"traceutil/trace.go:171","msg":"trace[813211219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:557; }","duration":"953.578971ms","start":"2026-01-29T19:01:21.744063Z","end":"2026-01-29T19:01:22.697642Z","steps":["trace[813211219] 'agreement among raft nodes before linearized reading'  (duration: 953.492958ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:22.697681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:21.744044Z","time spent":"953.629863ms","remote":"127.0.0.1:42126","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-29T19:01:22.698684Z","caller":"traceutil/trace.go:171","msg":"trace[1455457331] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"1.303905711s","start":"2026-01-29T19:01:21.394725Z","end":"2026-01-29T19:01:22.698631Z","steps":["trace[1455457331] 'process raft request'  (duration: 1.302604422s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:22.698782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:21.394719Z","time spent":"1.304006426s","remote":"127.0.0.1:42448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:548 > 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-01-29T19:01:22.699012Z","caller":"traceutil/trace.go:171","msg":"trace[1526240966] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"1.303137282s","start":"2026-01-29T19:01:21.395863Z","end":"2026-01-29T19:01:22.699Z","steps":["trace[1526240966] 'process raft request'  (duration: 1.301562173s)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:22.699075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:21.395856Z","time spent":"1.303184274s","remote":"127.0.0.1:42448","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:553 > 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-29T19:01:24.417782Z","caller":"traceutil/trace.go:171","msg":"trace[1730339949] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:582; }","duration":"128.679215ms","start":"2026-01-29T19:01:24.289088Z","end":"2026-01-29T19:01:24.417768Z","steps":["trace[1730339949] 'read index received'  (duration: 50.587125ms)","trace[1730339949] 'applied index is now lower than readState.Index'  (duration: 78.09153ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:01:24.417938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.841121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-01-29T19:01:24.417955Z","caller":"traceutil/trace.go:171","msg":"trace[1085277308] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:564; }","duration":"128.891413ms","start":"2026-01-29T19:01:24.289058Z","end":"2026-01-29T19:01:24.41795Z","steps":["trace[1085277308] 'agreement among raft nodes before linearized reading'  (duration: 128.760318ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:24.418244Z","caller":"traceutil/trace.go:171","msg":"trace[1743071894] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"269.452276ms","start":"2026-01-29T19:01:24.148771Z","end":"2026-01-29T19:01:24.418223Z","steps":["trace[1743071894] 'process raft request'  (duration: 190.91104ms)","trace[1743071894] 'compare'  (duration: 77.909883ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:01:24.897217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.79981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-29T19:01:24.897276Z","caller":"traceutil/trace.go:171","msg":"trace[224526844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:566; }","duration":"189.889793ms","start":"2026-01-29T19:01:24.707374Z","end":"2026-01-29T19:01:24.897264Z","steps":["trace[224526844] 'range keys from in-memory index tree'  (duration: 189.698296ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:24.89729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.926979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:24.897337Z","caller":"traceutil/trace.go:171","msg":"trace[396862290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"149.997841ms","start":"2026-01-29T19:01:24.747326Z","end":"2026-01-29T19:01:24.897324Z","steps":["trace[396862290] 'range keys from in-memory index tree'  (duration: 149.881147ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:24.89753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.112221ms","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-29T19:01:24.897548Z","caller":"traceutil/trace.go:171","msg":"trace[1891040756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:566; }","duration":"238.154653ms","start":"2026-01-29T19:01:24.659388Z","end":"2026-01-29T19:01:24.897543Z","steps":["trace[1891040756] 'range keys from in-memory index tree'  (duration: 237.993796ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:24.897627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.957592ms","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-29T19:01:24.897645Z","caller":"traceutil/trace.go:171","msg":"trace[2118593843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:566; }","duration":"191.012563ms","start":"2026-01-29T19:01:24.706627Z","end":"2026-01-29T19:01:24.897639Z","steps":["trace[2118593843] 'range keys from in-memory index tree'  (duration: 190.865658ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:26.721888Z","caller":"traceutil/trace.go:171","msg":"trace[1104511210] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"383.119501ms","start":"2026-01-29T19:01:26.338742Z","end":"2026-01-29T19:01:26.721861Z","steps":["trace[1104511210] 'process raft request'  (duration: 380.929043ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:26.722023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:26.338719Z","time spent":"383.240487ms","remote":"127.0.0.1:42202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" value_size:3111 >> failure:<>"}
{"level":"info","ts":"2026-01-29T19:01:26.722846Z","caller":"traceutil/trace.go:171","msg":"trace[1458811202] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"181.540175ms","start":"2026-01-29T19:01:26.541293Z","end":"2026-01-29T19:01:26.722833Z","steps":["trace[1458811202] 'process raft request'  (duration: 181.484943ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:28.471942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.263367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-01-29T19:01:28.471997Z","caller":"traceutil/trace.go:171","msg":"trace[1718345571] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:629; }","duration":"133.36649ms","start":"2026-01-29T19:01:28.338617Z","end":"2026-01-29T19:01:28.471984Z","steps":["trace[1718345571] 'range keys from in-memory index tree'  (duration: 133.124161ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:31.635353Z","caller":"traceutil/trace.go:171","msg":"trace[16285800] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:686; }","duration":"362.334334ms","start":"2026-01-29T19:01:31.273003Z","end":"2026-01-29T19:01:31.635337Z","steps":["trace[16285800] 'read index received'  (duration: 362.205709ms)","trace[16285800] 'applied index is now lower than readState.Index'  (duration: 128.185µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:31.63542Z","caller":"traceutil/trace.go:171","msg":"trace[1968460224] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"362.484449ms","start":"2026-01-29T19:01:31.272929Z","end":"2026-01-29T19:01:31.635413Z","steps":["trace[1968460224] 'process raft request'  (duration: 362.320024ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:31.635483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:31.272922Z","time spent":"362.51366ms","remote":"127.0.0.1:42348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4225,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:648 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4191 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-01-29T19:01:31.635671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.462719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-01-29T19:01:31.635757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.83106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:31.63578Z","caller":"traceutil/trace.go:171","msg":"trace[957172301] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:664; }","duration":"193.864281ms","start":"2026-01-29T19:01:31.441908Z","end":"2026-01-29T19:01:31.635773Z","steps":["trace[957172301] 'agreement among raft nodes before linearized reading'  (duration: 193.82574ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:31.635775Z","caller":"traceutil/trace.go:171","msg":"trace[1019671362] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:664; }","duration":"362.586673ms","start":"2026-01-29T19:01:31.27317Z","end":"2026-01-29T19:01:31.635756Z","steps":["trace[1019671362] 'agreement among raft nodes before linearized reading'  (duration: 362.418047ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:31.635844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:31.273159Z","time spent":"362.674636ms","remote":"127.0.0.1:36410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-01-29T19:01:31.635861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.853072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:31.635876Z","caller":"traceutil/trace.go:171","msg":"trace[1257358094] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:664; }","duration":"362.881214ms","start":"2026-01-29T19:01:31.27299Z","end":"2026-01-29T19:01:31.635871Z","steps":["trace[1257358094] 'agreement among raft nodes before linearized reading'  (duration: 362.857493ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:31.63591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:31.272987Z","time spent":"362.916795ms","remote":"127.0.0.1:36410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:01:31.635984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.275151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:31.635998Z","caller":"traceutil/trace.go:171","msg":"trace[1117095349] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:664; }","duration":"181.300152ms","start":"2026-01-29T19:01:31.454693Z","end":"2026-01-29T19:01:31.635993Z","steps":["trace[1117095349] 'agreement among raft nodes before linearized reading'  (duration: 181.274941ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:31.636059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.372415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:31.63607Z","caller":"traceutil/trace.go:171","msg":"trace[594496784] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:664; }","duration":"181.398555ms","start":"2026-01-29T19:01:31.454668Z","end":"2026-01-29T19:01:31.636067Z","steps":["trace[594496784] 'agreement among raft nodes before linearized reading'  (duration: 181.381045ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:31.636141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.52088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:31.636153Z","caller":"traceutil/trace.go:171","msg":"trace[956737799] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:664; }","duration":"181.557321ms","start":"2026-01-29T19:01:31.454592Z","end":"2026-01-29T19:01:31.63615Z","steps":["trace[956737799] 'agreement among raft nodes before linearized reading'  (duration: 181.53545ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:31.636166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.174825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:31.636228Z","caller":"traceutil/trace.go:171","msg":"trace[1492960468] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:664; }","duration":"195.228207ms","start":"2026-01-29T19:01:31.440961Z","end":"2026-01-29T19:01:31.636189Z","steps":["trace[1492960468] 'agreement among raft nodes before linearized reading'  (duration: 195.177966ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:31.636444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.39011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:31.636461Z","caller":"traceutil/trace.go:171","msg":"trace[335298154] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:664; }","duration":"348.40864ms","start":"2026-01-29T19:01:31.288047Z","end":"2026-01-29T19:01:31.636456Z","steps":["trace[335298154] 'agreement among raft nodes before linearized reading'  (duration: 348.379289ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:31.636475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:31.288006Z","time spent":"348.464992ms","remote":"127.0.0.1:36414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "}
{"level":"warn","ts":"2026-01-29T19:01:31.636497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.999455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-01-29T19:01:31.63653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.464442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:31.636526Z","caller":"traceutil/trace.go:171","msg":"trace[1859922213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:664; }","duration":"216.121959ms","start":"2026-01-29T19:01:31.420396Z","end":"2026-01-29T19:01:31.636518Z","steps":["trace[1859922213] 'agreement among raft nodes before linearized reading'  (duration: 215.969373ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:31.636544Z","caller":"traceutil/trace.go:171","msg":"trace[634396444] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:664; }","duration":"348.486132ms","start":"2026-01-29T19:01:31.288054Z","end":"2026-01-29T19:01:31.63654Z","steps":["trace[634396444] 'agreement among raft nodes before linearized reading'  (duration: 348.463672ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:31.636559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:31.288051Z","time spent":"348.504043ms","remote":"127.0.0.1:36414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-01-29T19:01:31.63673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.67779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-29T19:01:31.636745Z","caller":"traceutil/trace.go:171","msg":"trace[375181179] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:664; }","duration":"348.71018ms","start":"2026-01-29T19:01:31.288031Z","end":"2026-01-29T19:01:31.636741Z","steps":["trace[375181179] 'agreement among raft nodes before linearized reading'  (duration: 348.684839ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:31.636759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:31.288022Z","time spent":"348.734071ms","remote":"127.0.0.1:36414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "}
{"level":"info","ts":"2026-01-29T19:01:31.772826Z","caller":"traceutil/trace.go:171","msg":"trace[43570089] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"123.807172ms","start":"2026-01-29T19:01:31.649003Z","end":"2026-01-29T19:01:31.772811Z","steps":["trace[43570089] 'process raft request'  (duration: 117.158295ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:32.151666Z","caller":"traceutil/trace.go:171","msg":"trace[1387906204] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"147.048139ms","start":"2026-01-29T19:01:32.004599Z","end":"2026-01-29T19:01:32.151647Z","steps":["trace[1387906204] 'process raft request'  (duration: 99.273668ms)","trace[1387906204] 'compare'  (duration: 47.684528ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:32.227878Z","caller":"traceutil/trace.go:171","msg":"trace[457962431] linearizableReadLoop","detail":"{readStateIndex:691; appliedIndex:689; }","duration":"174.307288ms","start":"2026-01-29T19:01:32.053551Z","end":"2026-01-29T19:01:32.227858Z","steps":["trace[457962431] 'read index received'  (duration: 50.330437ms)","trace[457962431] 'applied index is now lower than readState.Index'  (duration: 123.976121ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:32.227902Z","caller":"traceutil/trace.go:171","msg":"trace[1128270366] transaction","detail":"{read_only:false; number_of_response:0; response_revision:667; }","duration":"221.344823ms","start":"2026-01-29T19:01:32.006532Z","end":"2026-01-29T19:01:32.227877Z","steps":["trace[1128270366] 'process raft request'  (duration: 221.266241ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:32.228058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.489924ms","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-01-29T19:01:32.228076Z","caller":"traceutil/trace.go:171","msg":"trace[2071452382] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:667; }","duration":"174.550006ms","start":"2026-01-29T19:01:32.053521Z","end":"2026-01-29T19:01:32.228071Z","steps":["trace[2071452382] 'agreement among raft nodes before linearized reading'  (duration: 174.433262ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:33.062828Z","caller":"traceutil/trace.go:171","msg":"trace[2101092233] linearizableReadLoop","detail":"{readStateIndex:695; appliedIndex:694; }","duration":"127.065724ms","start":"2026-01-29T19:01:32.935743Z","end":"2026-01-29T19:01:33.062809Z","steps":["trace[2101092233] 'read index received'  (duration: 126.928229ms)","trace[2101092233] 'applied index is now lower than readState.Index'  (duration: 136.805µs)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:33.063018Z","caller":"traceutil/trace.go:171","msg":"trace[2131745287] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"316.547103ms","start":"2026-01-29T19:01:32.746462Z","end":"2026-01-29T19:01:33.06301Z","steps":["trace[2131745287] 'process raft request'  (duration: 316.253904ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:33.06309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:32.74645Z","time spent":"316.593215ms","remote":"127.0.0.1:36366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2322,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumnodes/instance\" mod_revision:670 > success:<request_put:<key:\"/registry/cilium.io/ciliumnodes/instance\" value_size:2274 >> failure:<request_range:<key:\"/registry/cilium.io/ciliumnodes/instance\" > >"}
{"level":"warn","ts":"2026-01-29T19:01:33.063258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.516668ms","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-29T19:01:33.063285Z","caller":"traceutil/trace.go:171","msg":"trace[20369780] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:671; }","duration":"127.58442ms","start":"2026-01-29T19:01:32.935693Z","end":"2026-01-29T19:01:33.063278Z","steps":["trace[20369780] 'agreement among raft nodes before linearized reading'  (duration: 127.503027ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:33.063406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.862088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-29T19:01:33.063428Z","caller":"traceutil/trace.go:171","msg":"trace[1544576073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:671; }","duration":"121.896999ms","start":"2026-01-29T19:01:32.941526Z","end":"2026-01-29T19:01:33.063423Z","steps":["trace[1544576073] 'agreement among raft nodes before linearized reading'  (duration: 121.842507ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:34.210159Z","caller":"traceutil/trace.go:171","msg":"trace[566454265] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:698; }","duration":"328.883276ms","start":"2026-01-29T19:01:33.881258Z","end":"2026-01-29T19:01:34.210141Z","steps":["trace[566454265] 'read index received'  (duration: 328.761891ms)","trace[566454265] 'applied index is now lower than readState.Index'  (duration: 120.805µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:01:34.210297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.022871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-m2p9w.188f48dcd4b1a3d1\" ","response":"range_response_count:1 size:795"}
{"level":"info","ts":"2026-01-29T19:01:34.210318Z","caller":"traceutil/trace.go:171","msg":"trace[1962552014] range","detail":"{range_begin:/registry/events/kube-system/cilium-m2p9w.188f48dcd4b1a3d1; range_end:; response_count:1; response_revision:675; }","duration":"329.081103ms","start":"2026-01-29T19:01:33.881232Z","end":"2026-01-29T19:01:34.210314Z","steps":["trace[1962552014] 'agreement among raft nodes before linearized reading'  (duration: 328.970719ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:34.210337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:33.88122Z","time spent":"329.112644ms","remote":"127.0.0.1:42230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":817,"request content":"key:\"/registry/events/kube-system/cilium-m2p9w.188f48dcd4b1a3d1\" "}
{"level":"info","ts":"2026-01-29T19:01:34.210588Z","caller":"traceutil/trace.go:171","msg":"trace[1006623966] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"432.235034ms","start":"2026-01-29T19:01:33.778347Z","end":"2026-01-29T19:01:34.210582Z","steps":["trace[1006623966] 'process raft request'  (duration: 431.710057ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:34.210637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:33.778339Z","time spent":"432.267626ms","remote":"127.0.0.1:42448","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:665 > 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-29T19:01:34.480562Z","caller":"traceutil/trace.go:171","msg":"trace[1003721660] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"234.607242ms","start":"2026-01-29T19:01:34.245932Z","end":"2026-01-29T19:01:34.480539Z","steps":["trace[1003721660] 'read index received'  (duration: 214.351913ms)","trace[1003721660] 'applied index is now lower than readState.Index'  (duration: 20.254659ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:34.48073Z","caller":"traceutil/trace.go:171","msg":"trace[1099653171] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"265.510631ms","start":"2026-01-29T19:01:34.215213Z","end":"2026-01-29T19:01:34.480723Z","steps":["trace[1099653171] 'process raft request'  (duration: 245.061886ms)","trace[1099653171] 'compare'  (duration: 20.058312ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:01:34.480939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.999624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-01-29T19:01:34.480962Z","caller":"traceutil/trace.go:171","msg":"trace[2003307482] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:676; }","duration":"235.055116ms","start":"2026-01-29T19:01:34.245901Z","end":"2026-01-29T19:01:34.480957Z","steps":["trace[2003307482] 'agreement among raft nodes before linearized reading'  (duration: 234.945023ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:34.524457Z","caller":"traceutil/trace.go:171","msg":"trace[2129070811] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"277.743394ms","start":"2026-01-29T19:01:34.246699Z","end":"2026-01-29T19:01:34.524442Z","steps":["trace[2129070811] 'process raft request'  (duration: 277.676721ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:34.524877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.971673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-01-29T19:01:34.524899Z","caller":"traceutil/trace.go:171","msg":"trace[1817213306] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:677; }","duration":"235.025554ms","start":"2026-01-29T19:01:34.289868Z","end":"2026-01-29T19:01:34.524894Z","steps":["trace[1817213306] 'agreement among raft nodes before linearized reading'  (duration: 234.923521ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:35.091082Z","caller":"traceutil/trace.go:171","msg":"trace[1080581482] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"482.155348ms","start":"2026-01-29T19:01:34.608913Z","end":"2026-01-29T19:01:35.091068Z","steps":["trace[1080581482] 'process raft request'  (duration: 481.340282ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:35.091155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:34.608897Z","time spent":"482.22366ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2261,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-77cccfdc44-llmrm\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-77cccfdc44-llmrm\" value_size:2181 >> failure:<>"}
{"level":"info","ts":"2026-01-29T19:01:35.235142Z","caller":"traceutil/trace.go:171","msg":"trace[1228676014] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:707; }","duration":"126.301123ms","start":"2026-01-29T19:01:35.108826Z","end":"2026-01-29T19:01:35.235127Z","steps":["trace[1228676014] 'read index received'  (duration: 99.912412ms)","trace[1228676014] 'applied index is now lower than readState.Index'  (duration: 26.388171ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:35.235419Z","caller":"traceutil/trace.go:171","msg":"trace[1457450375] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"625.331432ms","start":"2026-01-29T19:01:34.610079Z","end":"2026-01-29T19:01:35.23541Z","steps":["trace[1457450375] 'process raft request'  (duration: 598.63902ms)","trace[1457450375] 'compare'  (duration: 26.271857ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-29T19:01:35.235472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:34.610073Z","time spent":"625.366333ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2262,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-77cccfdc44-wbpgm\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-77cccfdc44-wbpgm\" value_size:2182 >> failure:<>"}
{"level":"info","ts":"2026-01-29T19:01:35.235622Z","caller":"traceutil/trace.go:171","msg":"trace[365756200] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"548.774904ms","start":"2026-01-29T19:01:34.686842Z","end":"2026-01-29T19:01:35.235617Z","steps":["trace[365756200] 'process raft request'  (duration: 548.228996ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:35.235653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:34.686827Z","time spent":"548.805486ms","remote":"127.0.0.1:42448","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:566 > 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-29T19:01:35.235713Z","caller":"traceutil/trace.go:171","msg":"trace[1750006922] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"436.723697ms","start":"2026-01-29T19:01:34.798985Z","end":"2026-01-29T19:01:35.235708Z","steps":["trace[1750006922] 'process raft request'  (duration: 436.121547ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:35.235731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:01:34.798969Z","time spent":"436.753369ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2261,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-5dd5756b68-n5wcb\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-5dd5756b68-n5wcb\" value_size:2181 >> failure:<>"}
{"level":"warn","ts":"2026-01-29T19:01:35.235828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.001626ms","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-29T19:01:35.235843Z","caller":"traceutil/trace.go:171","msg":"trace[901015952] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:685; }","duration":"127.033317ms","start":"2026-01-29T19:01:35.108805Z","end":"2026-01-29T19:01:35.235838Z","steps":["trace[901015952] 'agreement among raft nodes before linearized reading'  (duration: 126.973755ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:35.235929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.161893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-29T19:01:35.235944Z","caller":"traceutil/trace.go:171","msg":"trace[1565542317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:685; }","duration":"109.189994ms","start":"2026-01-29T19:01:35.12675Z","end":"2026-01-29T19:01:35.23594Z","steps":["trace[1565542317] 'agreement among raft nodes before linearized reading'  (duration: 109.148243ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:01:35.236091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.850031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-29T19:01:35.236103Z","caller":"traceutil/trace.go:171","msg":"trace[1072974027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:685; }","duration":"107.870821ms","start":"2026-01-29T19:01:35.128229Z","end":"2026-01-29T19:01:35.2361Z","steps":["trace[1072974027] 'agreement among raft nodes before linearized reading'  (duration: 107.83571ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:35.437593Z","caller":"traceutil/trace.go:171","msg":"trace[956385871] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"194.725846ms","start":"2026-01-29T19:01:35.242852Z","end":"2026-01-29T19:01:35.437578Z","steps":["trace[956385871] 'process raft request'  (duration: 161.845193ms)","trace[956385871] 'compare'  (duration: 32.335155ms)"],"step_count":2}
{"level":"info","ts":"2026-01-29T19:01:35.444719Z","caller":"traceutil/trace.go:171","msg":"trace[1135364679] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"201.703213ms","start":"2026-01-29T19:01:35.243007Z","end":"2026-01-29T19:01:35.44471Z","steps":["trace[1135364679] 'process raft request'  (duration: 201.685113ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:35.444962Z","caller":"traceutil/trace.go:171","msg":"trace[1402948049] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"201.976042ms","start":"2026-01-29T19:01:35.24298Z","end":"2026-01-29T19:01:35.444956Z","steps":["trace[1402948049] 'process raft request'  (duration: 201.668912ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:36.057001Z","caller":"traceutil/trace.go:171","msg":"trace[118391139] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"163.990345ms","start":"2026-01-29T19:01:35.892996Z","end":"2026-01-29T19:01:36.056986Z","steps":["trace[118391139] 'process raft request'  (duration: 163.898382ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:36.290581Z","caller":"traceutil/trace.go:171","msg":"trace[306046543] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"110.463346ms","start":"2026-01-29T19:01:36.180103Z","end":"2026-01-29T19:01:36.290566Z","steps":["trace[306046543] 'process raft request'  (duration: 110.384084ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:01:36.303221Z","caller":"traceutil/trace.go:171","msg":"trace[550416803] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"112.579725ms","start":"2026-01-29T19:01:36.190629Z","end":"2026-01-29T19:01:36.303209Z","steps":["trace[550416803] 'process raft request'  (duration: 112.269575ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:02:34.623787Z","caller":"traceutil/trace.go:171","msg":"trace[1489029179] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"107.852487ms","start":"2026-01-29T19:02:34.51591Z","end":"2026-01-29T19:02:34.623763Z","steps":["trace[1489029179] 'process raft request'  (duration: 107.686824ms)"],"step_count":1}
{"level":"info","ts":"2026-01-29T19:02:51.528643Z","caller":"traceutil/trace.go:171","msg":"trace[1683235375] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"530.714734ms","start":"2026-01-29T19:02:50.997903Z","end":"2026-01-29T19:02:51.528618Z","steps":["trace[1683235375] 'process raft request'  (duration: 530.032962ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-29T19:02:51.528811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T19:02:50.99789Z","time spent":"530.829666ms","remote":"127.0.0.1:42448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:990 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}