{"level":"warn","ts":"2026-02-06T05:57:22.19644Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-06T05:57:22.196561Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-06T05:57:22.19677Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-06T05:57:22.196803Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-02-06T05:57:22.196833Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-06T05:57:22.197393Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-02-06T05:57:22.197537Z","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://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-06T05:57:22.203232Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.38947ms"} {"level":"info","ts":"2026-02-06T05:57:22.212414Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-02-06T05:57:22.212481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-02-06T05:57:22.21251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-02-06T05:57:22.212544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-06T05:57:22.212564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-02-06T05:57:22.212604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-02-06T05:57:22.224274Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-06T05:57:22.24055Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-06T05:57:22.253628Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-02-06T05:57:22.262778Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-06T05:57:22.263124Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-06T05:57:22.263318Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-06T05:57:22.26341Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-06T05:57:22.267421Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-06T05:57:22.268097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-02-06T05:57:22.26822Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-02-06T05:57:22.270082Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-06T05:57:22.270183Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-02-06T05:57:22.274368Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-02-06T05:57:22.275432Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-06T05:57:22.275484Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-06T05:57:22.526379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-02-06T05:57:22.526539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-02-06T05:57:22.526593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-02-06T05:57:22.526676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-02-06T05:57:22.526726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-02-06T05:57:22.526765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-02-06T05:57:22.526821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-02-06T05:57:22.535169Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-02-06T05:57:22.535252Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-06T05:57:22.535599Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-06T05:57:22.535942Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-06T05:57:22.536154Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-06T05:57:22.536187Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-06T05:57:22.537665Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-02-06T05:57:22.539458Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-06T05:57:22.576954Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-02-06T05:57:22.577289Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-06T05:57:22.579481Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-02-06T05:57:27.852614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.723516ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-06T05:57:27.85279Z","caller":"traceutil/trace.go:171","msg":"trace[38369567] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"154.856462ms","start":"2026-02-06T05:57:27.697913Z","end":"2026-02-06T05:57:27.85277Z","steps":["trace[38369567] 'process raft request' (duration: 21.207646ms)","trace[38369567] 'compare' (duration: 132.571052ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:57:27.852993Z","caller":"traceutil/trace.go:171","msg":"trace[777876992] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"155.056229ms","start":"2026-02-06T05:57:27.697931Z","end":"2026-02-06T05:57:27.852987Z","steps":["trace[777876992] 'process raft request' (duration: 154.852342ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:27.853109Z","caller":"traceutil/trace.go:171","msg":"trace[362240583] transaction","detail":"{read_only:false; number_of_response:0; response_revision:239; }","duration":"122.832636ms","start":"2026-02-06T05:57:27.730272Z","end":"2026-02-06T05:57:27.853105Z","steps":["trace[362240583] 'process raft request' (duration: 122.601159ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:27.853216Z","caller":"traceutil/trace.go:171","msg":"trace[1074475307] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"121.98643ms","start":"2026-02-06T05:57:27.731225Z","end":"2026-02-06T05:57:27.853211Z","steps":["trace[1074475307] 'process raft request' (duration: 121.68594ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:32.945034Z","caller":"traceutil/trace.go:171","msg":"trace[1512564113] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"101.791406ms","start":"2026-02-06T05:57:32.843219Z","end":"2026-02-06T05:57:32.945011Z","steps":["trace[1512564113] 'process raft request' (duration: 101.690243ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:32.945311Z","caller":"traceutil/trace.go:171","msg":"trace[553382607] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"108.393073ms","start":"2026-02-06T05:57:32.836884Z","end":"2026-02-06T05:57:32.945277Z","steps":["trace[553382607] 'process raft request' (duration: 34.559225ms)","trace[553382607] 'compare' (duration: 73.109695ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:57:34.833832Z","caller":"traceutil/trace.go:171","msg":"trace[1496645764] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"122.300209ms","start":"2026-02-06T05:57:34.711498Z","end":"2026-02-06T05:57:34.833799Z","steps":["trace[1496645764] 'process raft request' (duration: 122.155335ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:34.835527Z","caller":"traceutil/trace.go:171","msg":"trace[1368999887] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"113.965998ms","start":"2026-02-06T05:57:34.721538Z","end":"2026-02-06T05:57:34.835504Z","steps":["trace[1368999887] 'process raft request' (duration: 113.856444ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:40.594716Z","caller":"traceutil/trace.go:171","msg":"trace[2102661773] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"352.269974ms","start":"2026-02-06T05:57:40.242425Z","end":"2026-02-06T05:57:40.594695Z","steps":["trace[2102661773] 'process raft request' (duration: 351.907272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:40.595064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:40.242412Z","time spent":"352.499632ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:57:41.143171Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334365517771614076,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-06T05:57:41.56169Z","caller":"traceutil/trace.go:171","msg":"trace[869003254] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"959.82267ms","start":"2026-02-06T05:57:40.601837Z","end":"2026-02-06T05:57:41.561659Z","steps":["trace[869003254] 'process raft request' (duration: 956.265796ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:41.561845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:40.601794Z","time spent":"959.982724ms","remote":"127.0.0.1:55206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:57:41.562267Z","caller":"traceutil/trace.go:171","msg":"trace[1387124201] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:413; }","duration":"919.778674ms","start":"2026-02-06T05:57:40.642479Z","end":"2026-02-06T05:57:41.562257Z","steps":["trace[1387124201] 'read index received' (duration: 915.572019ms)","trace[1387124201] 'applied index is now lower than readState.Index' (duration: 4.205725ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:57:41.563527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.609905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-06T05:57:41.56356Z","caller":"traceutil/trace.go:171","msg":"trace[483843971] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:404; }","duration":"697.716869ms","start":"2026-02-06T05:57:40.865835Z","end":"2026-02-06T05:57:41.563552Z","steps":["trace[483843971] 'agreement among raft nodes before linearized reading' (duration: 697.659268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:41.56358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:40.865814Z","time spent":"697.76178ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-06T05:57:41.563748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.263802ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:57:41.563791Z","caller":"traceutil/trace.go:171","msg":"trace[485280045] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:404; }","duration":"921.312014ms","start":"2026-02-06T05:57:40.642473Z","end":"2026-02-06T05:57:41.563785Z","steps":["trace[485280045] 'agreement among raft nodes before linearized reading' (duration: 919.843727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:41.564004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.95248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:57:41.564023Z","caller":"traceutil/trace.go:171","msg":"trace[1728430087] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:404; }","duration":"446.008472ms","start":"2026-02-06T05:57:41.118009Z","end":"2026-02-06T05:57:41.564017Z","steps":["trace[1728430087] 'agreement among raft nodes before linearized reading' (duration: 445.974911ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:41.564038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:41.117989Z","time spent":"446.045663ms","remote":"127.0.0.1:54988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-06T05:57:41.56412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.248324ms","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-02-06T05:57:41.564136Z","caller":"traceutil/trace.go:171","msg":"trace[301485921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:404; }","duration":"587.291385ms","start":"2026-02-06T05:57:40.97684Z","end":"2026-02-06T05:57:41.564131Z","steps":["trace[301485921] 'agreement among raft nodes before linearized reading' (duration: 587.264154ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:41.564157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:40.976827Z","time spent":"587.326447ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-06T05:57:54.189301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.826879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-06T05:57:54.189367Z","caller":"traceutil/trace.go:171","msg":"trace[491989697] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"440.692201ms","start":"2026-02-06T05:57:53.748664Z","end":"2026-02-06T05:57:54.189356Z","steps":["trace[491989697] 'process raft request' (duration: 299.754359ms)","trace[491989697] 'compare' (duration: 140.769877ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:57:54.189396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:53.748653Z","time spent":"440.729842ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:57:59.021462Z","caller":"traceutil/trace.go:171","msg":"trace[640403614] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:498; }","duration":"220.737533ms","start":"2026-02-06T05:57:58.800704Z","end":"2026-02-06T05:57:59.021442Z","steps":["trace[640403614] 'read index received' (duration: 220.564447ms)","trace[640403614] 'applied index is now lower than readState.Index' (duration: 172.206µs)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:57:59.02165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.928539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:57:59.02171Z","caller":"traceutil/trace.go:171","msg":"trace[1685459125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:485; }","duration":"221.011122ms","start":"2026-02-06T05:57:58.800685Z","end":"2026-02-06T05:57:59.021696Z","steps":["trace[1685459125] 'agreement among raft nodes before linearized reading' (duration: 220.834596ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:59.021921Z","caller":"traceutil/trace.go:171","msg":"trace[424373790] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"241.029444ms","start":"2026-02-06T05:57:58.78088Z","end":"2026-02-06T05:57:59.021909Z","steps":["trace[424373790] 'process raft request' (duration: 240.452465ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:59.635712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.856159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:57:59.636018Z","caller":"traceutil/trace.go:171","msg":"trace[573377030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"519.163129ms","start":"2026-02-06T05:57:59.116802Z","end":"2026-02-06T05:57:59.635965Z","steps":["trace[573377030] 'range keys from in-memory index tree' (duration: 518.798508ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:59.636228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:59.116787Z","time spent":"519.424207ms","remote":"127.0.0.1:54984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-06T05:58:00.069391Z","caller":"traceutil/trace.go:171","msg":"trace[1085625812] linearizableReadLoop","detail":"{readStateIndex:501; appliedIndex:500; }","duration":"242.413188ms","start":"2026-02-06T05:57:59.826961Z","end":"2026-02-06T05:58:00.069374Z","steps":["trace[1085625812] 'read index received' (duration: 242.304665ms)","trace[1085625812] 'applied index is now lower than readState.Index' (duration: 107.603µs)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:58:00.069554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.566373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-06T05:58:00.069578Z","caller":"traceutil/trace.go:171","msg":"trace[1954520663] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:487; }","duration":"242.665656ms","start":"2026-02-06T05:57:59.826904Z","end":"2026-02-06T05:58:00.06957Z","steps":["trace[1954520663] 'agreement among raft nodes before linearized reading' (duration: 242.544562ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:00.069654Z","caller":"traceutil/trace.go:171","msg":"trace[1047616606] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"364.588799ms","start":"2026-02-06T05:57:59.705059Z","end":"2026-02-06T05:58:00.069648Z","steps":["trace[1047616606] 'process raft request' (duration: 364.217687ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:00.069706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:59.705045Z","time spent":"364.62143ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:58:02.220723Z","caller":"traceutil/trace.go:171","msg":"trace[454758653] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"266.400979ms","start":"2026-02-06T05:58:01.954291Z","end":"2026-02-06T05:58:02.220692Z","steps":["trace[454758653] 'process raft request' (duration: 266.276355ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:02.225605Z","caller":"traceutil/trace.go:171","msg":"trace[2115199268] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:520; }","duration":"152.098941ms","start":"2026-02-06T05:58:02.073493Z","end":"2026-02-06T05:58:02.225592Z","steps":["trace[2115199268] 'read index received' (duration: 147.779302ms)","trace[2115199268] 'applied index is now lower than readState.Index' (duration: 4.318789ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:58:02.225879Z","caller":"traceutil/trace.go:171","msg":"trace[1445692054] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"271.292046ms","start":"2026-02-06T05:58:01.954579Z","end":"2026-02-06T05:58:02.225871Z","steps":["trace[1445692054] 'process raft request' (duration: 270.924514ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:02.226178Z","caller":"traceutil/trace.go:171","msg":"trace[798769190] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"271.348318ms","start":"2026-02-06T05:58:01.954822Z","end":"2026-02-06T05:58:02.22617Z","steps":["trace[798769190] 'process raft request' (duration: 270.733118ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:02.226425Z","caller":"traceutil/trace.go:171","msg":"trace[1440427887] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"181.07792ms","start":"2026-02-06T05:58:02.04534Z","end":"2026-02-06T05:58:02.226418Z","steps":["trace[1440427887] 'process raft request' (duration: 180.233823ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:02.226669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.165525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-06T05:58:02.226789Z","caller":"traceutil/trace.go:171","msg":"trace[721225004] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:508; }","duration":"153.30581ms","start":"2026-02-06T05:58:02.073459Z","end":"2026-02-06T05:58:02.226765Z","steps":["trace[721225004] 'agreement among raft nodes before linearized reading' (duration: 153.130984ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:02.227033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.442777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-06T05:58:02.227157Z","caller":"traceutil/trace.go:171","msg":"trace[1657841037] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:508; }","duration":"121.572331ms","start":"2026-02-06T05:58:02.105561Z","end":"2026-02-06T05:58:02.227134Z","steps":["trace[1657841037] 'agreement among raft nodes before linearized reading' (duration: 121.404116ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:02.227582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.779143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:58:02.22771Z","caller":"traceutil/trace.go:171","msg":"trace[1060764509] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:508; }","duration":"109.889636ms","start":"2026-02-06T05:58:02.117796Z","end":"2026-02-06T05:58:02.227686Z","steps":["trace[1060764509] 'agreement among raft nodes before linearized reading' (duration: 109.771262ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:29.168659Z","caller":"traceutil/trace.go:171","msg":"trace[1187387476] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"523.094995ms","start":"2026-02-06T05:58:28.645546Z","end":"2026-02-06T05:58:29.168641Z","steps":["trace[1187387476] 'process raft request' (duration: 522.997192ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:29.168781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:58:28.645527Z","time spent":"523.191229ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:58:29.355197Z","caller":"traceutil/trace.go:171","msg":"trace[1091129300] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:731; }","duration":"135.383364ms","start":"2026-02-06T05:58:29.219796Z","end":"2026-02-06T05:58:29.355179Z","steps":["trace[1091129300] 'read index received' (duration: 135.239559ms)","trace[1091129300] 'applied index is now lower than readState.Index' (duration: 143.115µs)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:58:29.35535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.54218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-06T05:58:29.355373Z","caller":"traceutil/trace.go:171","msg":"trace[2132098649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:710; }","duration":"135.602792ms","start":"2026-02-06T05:58:29.219763Z","end":"2026-02-06T05:58:29.355366Z","steps":["trace[2132098649] 'agreement among raft nodes before linearized reading' (duration: 135.483958ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:29.355594Z","caller":"traceutil/trace.go:171","msg":"trace[1606906027] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"531.948379ms","start":"2026-02-06T05:58:28.823638Z","end":"2026-02-06T05:58:29.355586Z","steps":["trace[1606906027] 'process raft request' (duration: 531.449553ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:29.355648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:58:28.823618Z","time spent":"531.991791ms","remote":"127.0.0.1:55204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4726,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:58:34.509977Z","caller":"traceutil/trace.go:171","msg":"trace[1770292546] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"124.810355ms","start":"2026-02-06T05:58:34.385144Z","end":"2026-02-06T05:58:34.509955Z","steps":["trace[1770292546] 'process raft request' (duration: 124.581687ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:34.510496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.002892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-06T05:58:34.510542Z","caller":"traceutil/trace.go:171","msg":"trace[1083021688] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:723; }","duration":"111.077704ms","start":"2026-02-06T05:58:34.399456Z","end":"2026-02-06T05:58:34.510534Z","steps":["trace[1083021688] 'agreement among raft nodes before linearized reading' (duration: 110.929369ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:34.510367Z","caller":"traceutil/trace.go:171","msg":"trace[1652843373] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:744; }","duration":"110.896399ms","start":"2026-02-06T05:58:34.39946Z","end":"2026-02-06T05:58:34.510357Z","steps":["trace[1652843373] 'read index received' (duration: 110.392912ms)","trace[1652843373] 'applied index is now lower than readState.Index' (duration: 460.135µs)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:58:34.51072Z","caller":"traceutil/trace.go:171","msg":"trace[185752241] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"124.510996ms","start":"2026-02-06T05:58:34.3862Z","end":"2026-02-06T05:58:34.510711Z","steps":["trace[185752241] 'process raft request' (duration: 124.080562ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:40.665644Z","caller":"traceutil/trace.go:171","msg":"trace[880630859] linearizableReadLoop","detail":"{readStateIndex:765; appliedIndex:764; }","duration":"128.305144ms","start":"2026-02-06T05:58:40.537326Z","end":"2026-02-06T05:58:40.665631Z","steps":["trace[880630859] 'read index received' (duration: 85.07834ms)","trace[880630859] 'applied index is now lower than readState.Index' (duration: 43.225973ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:58:40.665734Z","caller":"traceutil/trace.go:171","msg":"trace[1981289221] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"128.476919ms","start":"2026-02-06T05:58:40.537249Z","end":"2026-02-06T05:58:40.665726Z","steps":["trace[1981289221] 'process raft request' (duration: 113.605062ms)","trace[1981289221] 'compare' (duration: 14.725162ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:58:40.665853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.51445ms","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-02-06T05:58:40.66587Z","caller":"traceutil/trace.go:171","msg":"trace[1696810771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:741; }","duration":"128.551841ms","start":"2026-02-06T05:58:40.537312Z","end":"2026-02-06T05:58:40.665864Z","steps":["trace[1696810771] 'agreement among raft nodes before linearized reading' (duration: 128.472258ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:40.666136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.391108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-06T05:58:40.666215Z","caller":"traceutil/trace.go:171","msg":"trace[136200] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:741; }","duration":"124.506942ms","start":"2026-02-06T05:58:40.541694Z","end":"2026-02-06T05:58:40.666201Z","steps":["trace[136200] 'agreement among raft nodes before linearized reading' (duration: 124.343206ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:46.47617Z","caller":"traceutil/trace.go:171","msg":"trace[1143930822] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"254.268237ms","start":"2026-02-06T05:58:46.221876Z","end":"2026-02-06T05:58:46.476144Z","steps":["trace[1143930822] 'process raft request' (duration: 254.090592ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:47.620579Z","caller":"traceutil/trace.go:171","msg":"trace[1193048988] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"161.463197ms","start":"2026-02-06T05:58:47.459093Z","end":"2026-02-06T05:58:47.620556Z","steps":["trace[1193048988] 'read index received' (duration: 161.276081ms)","trace[1193048988] 'applied index is now lower than readState.Index' (duration: 186.206µs)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:58:47.620715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.596952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:58:47.620745Z","caller":"traceutil/trace.go:171","msg":"trace[1677056309] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:761; }","duration":"161.673044ms","start":"2026-02-06T05:58:47.459064Z","end":"2026-02-06T05:58:47.620737Z","steps":["trace[1677056309] 'agreement among raft nodes before linearized reading' (duration: 161.578671ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:47.621064Z","caller":"traceutil/trace.go:171","msg":"trace[880175733] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"170.565488ms","start":"2026-02-06T05:58:47.450486Z","end":"2026-02-06T05:58:47.621052Z","steps":["trace[880175733] 'process raft request' (duration: 169.946679ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:48.441864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.521224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:58:48.441933Z","caller":"traceutil/trace.go:171","msg":"trace[231294675] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:761; }","duration":"323.637518ms","start":"2026-02-06T05:58:48.118279Z","end":"2026-02-06T05:58:48.441917Z","steps":["trace[231294675] 'range keys from in-memory index tree' (duration: 323.455482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:48.442002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:58:48.118259Z","time spent":"323.69941ms","remote":"127.0.0.1:54988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-06T05:58:48.884749Z","caller":"traceutil/trace.go:171","msg":"trace[1680415431] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:787; }","duration":"100.832357ms","start":"2026-02-06T05:58:48.783895Z","end":"2026-02-06T05:58:48.884727Z","steps":["trace[1680415431] 'read index received' (duration: 100.648591ms)","trace[1680415431] 'applied index is now lower than readState.Index' (duration: 183.066µs)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:58:48.884859Z","caller":"traceutil/trace.go:171","msg":"trace[604171339] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"212.222302ms","start":"2026-02-06T05:58:48.672628Z","end":"2026-02-06T05:58:48.88485Z","steps":["trace[604171339] 'process raft request' (duration: 211.972804ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:48.885205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.297522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-06T05:58:48.885248Z","caller":"traceutil/trace.go:171","msg":"trace[1676597500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:762; }","duration":"101.382364ms","start":"2026-02-06T05:58:48.783856Z","end":"2026-02-06T05:58:48.885238Z","steps":["trace[1676597500] 'agreement among raft nodes before linearized reading' (duration: 101.206699ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:59.099899Z","caller":"traceutil/trace.go:171","msg":"trace[612852859] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"140.249188ms","start":"2026-02-06T05:58:58.959609Z","end":"2026-02-06T05:58:59.099858Z","steps":["trace[612852859] 'process raft request' (duration: 140.088013ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:59.100565Z","caller":"traceutil/trace.go:171","msg":"trace[127110215] linearizableReadLoop","detail":"{readStateIndex:871; appliedIndex:871; }","duration":"132.388767ms","start":"2026-02-06T05:58:58.968165Z","end":"2026-02-06T05:58:59.100554Z","steps":["trace[127110215] 'read index received' (duration: 131.455967ms)","trace[127110215] 'applied index is now lower than readState.Index' (duration: 931.67µs)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:58:59.101356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.153082ms","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-02-06T05:58:59.101625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.914794ms","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-02-06T05:58:59.101662Z","caller":"traceutil/trace.go:171","msg":"trace[1811154305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:841; }","duration":"102.971936ms","start":"2026-02-06T05:58:58.998679Z","end":"2026-02-06T05:58:59.101651Z","steps":["trace[1811154305] 'agreement among raft nodes before linearized reading' (duration: 102.861852ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:58:59.102054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.047354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-06T05:58:59.102114Z","caller":"traceutil/trace.go:171","msg":"trace[791113058] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:841; }","duration":"101.123477ms","start":"2026-02-06T05:58:59.000959Z","end":"2026-02-06T05:58:59.102083Z","steps":["trace[791113058] 'agreement among raft nodes before linearized reading' (duration: 100.997483ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:59.102383Z","caller":"traceutil/trace.go:171","msg":"trace[1835635821] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:841; }","duration":"133.359518ms","start":"2026-02-06T05:58:58.968149Z","end":"2026-02-06T05:58:59.101509Z","steps":["trace[1835635821] 'agreement among raft nodes before linearized reading' (duration: 133.023798ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:58:59.774533Z","caller":"traceutil/trace.go:171","msg":"trace[306977386] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"107.79336ms","start":"2026-02-06T05:58:59.666722Z","end":"2026-02-06T05:58:59.774515Z","steps":["trace[306977386] 'process raft request' (duration: 107.687986ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:01.540641Z","caller":"traceutil/trace.go:171","msg":"trace[1238115779] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"434.767315ms","start":"2026-02-06T05:59:01.105859Z","end":"2026-02-06T05:59:01.540626Z","steps":["trace[1238115779] 'process raft request' (duration: 434.669842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:01.540759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:59:01.10585Z","time spent":"434.848837ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:59:01.540839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.480595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-06T05:59:01.540877Z","caller":"traceutil/trace.go:171","msg":"trace[1028803076] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:847; }","duration":"339.557888ms","start":"2026-02-06T05:59:01.201313Z","end":"2026-02-06T05:59:01.540871Z","steps":["trace[1028803076] 'agreement among raft nodes before linearized reading' (duration: 339.382512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:01.540899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:59:01.201285Z","time spent":"339.608559ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-06T05:59:01.540651Z","caller":"traceutil/trace.go:171","msg":"trace[878324622] linearizableReadLoop","detail":"{readStateIndex:877; appliedIndex:877; }","duration":"339.283359ms","start":"2026-02-06T05:59:01.201341Z","end":"2026-02-06T05:59:01.540625Z","steps":["trace[878324622] 'read index received' (duration: 339.261438ms)","trace[878324622] 'applied index is now lower than readState.Index' (duration: 19.971µs)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:59:02.308864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.463815ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-06T05:59:02.309021Z","caller":"traceutil/trace.go:171","msg":"trace[776667182] linearizableReadLoop","detail":"{readStateIndex:878; appliedIndex:877; }","duration":"768.02934ms","start":"2026-02-06T05:59:01.54098Z","end":"2026-02-06T05:59:02.309009Z","steps":["trace[776667182] 'read index received' (duration: 287.365067ms)","trace[776667182] 'applied index is now lower than readState.Index' (duration: 480.663253ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:59:02.309323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105997865s","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-02-06T05:59:02.309347Z","caller":"traceutil/trace.go:171","msg":"trace[1614810225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:847; }","duration":"1.106030397s","start":"2026-02-06T05:59:01.203308Z","end":"2026-02-06T05:59:02.309338Z","steps":["trace[1614810225] 'agreement among raft nodes before linearized reading' (duration: 1.105940544s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:02.309378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:59:01.203304Z","time spent":"1.106058368s","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-06T05:59:02.309517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106231673s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-06T05:59:02.309535Z","caller":"traceutil/trace.go:171","msg":"trace[440392453] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:847; }","duration":"1.106248953s","start":"2026-02-06T05:59:01.203281Z","end":"2026-02-06T05:59:02.30953Z","steps":["trace[440392453] 'agreement among raft nodes before linearized reading' (duration: 1.106199662s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:02.309551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:59:01.203252Z","time spent":"1.106295365s","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-06T05:59:02.309889Z","caller":"traceutil/trace.go:171","msg":"trace[903068799] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"766.436579ms","start":"2026-02-06T05:59:01.543443Z","end":"2026-02-06T05:59:02.309879Z","steps":["trace[903068799] 'process raft request' (duration: 765.491138ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:02.309959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:59:01.543432Z","time spent":"766.47815ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:59:02.312088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.460252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:59:02.312117Z","caller":"traceutil/trace.go:171","msg":"trace[1231146218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:848; }","duration":"533.509404ms","start":"2026-02-06T05:59:01.778599Z","end":"2026-02-06T05:59:02.312109Z","steps":["trace[1231146218] 'agreement among raft nodes before linearized reading' (duration: 531.455758ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:02.312136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:59:01.778566Z","time spent":"533.564946ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-06T05:59:02.312222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.878525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:59:02.312238Z","caller":"traceutil/trace.go:171","msg":"trace[737684147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:848; }","duration":"538.948758ms","start":"2026-02-06T05:59:01.773284Z","end":"2026-02-06T05:59:02.312233Z","steps":["trace[737684147] 'agreement among raft nodes before linearized reading' (duration: 536.584012ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:02.312253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:59:01.773266Z","time spent":"538.983818ms","remote":"127.0.0.1:54988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-06T05:59:02.312385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.51267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:59:02.312402Z","caller":"traceutil/trace.go:171","msg":"trace[247518436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:848; }","duration":"197.559351ms","start":"2026-02-06T05:59:02.114837Z","end":"2026-02-06T05:59:02.312397Z","steps":["trace[247518436] 'agreement among raft nodes before linearized reading' (duration: 195.211996ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:14.549108Z","caller":"traceutil/trace.go:171","msg":"trace[1503213716] linearizableReadLoop","detail":"{readStateIndex:914; appliedIndex:913; }","duration":"197.18278ms","start":"2026-02-06T05:59:14.351907Z","end":"2026-02-06T05:59:14.54909Z","steps":["trace[1503213716] 'read index received' (duration: 179.287328ms)","trace[1503213716] 'applied index is now lower than readState.Index' (duration: 17.894562ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:59:14.54919Z","caller":"traceutil/trace.go:171","msg":"trace[852603527] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"209.270487ms","start":"2026-02-06T05:59:14.339912Z","end":"2026-02-06T05:59:14.549183Z","steps":["trace[852603527] 'process raft request' (duration: 191.285302ms)","trace[852603527] 'compare' (duration: 17.80813ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:59:14.549341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.419808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-06T05:59:14.549357Z","caller":"traceutil/trace.go:171","msg":"trace[1181230744] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:881; }","duration":"197.47509ms","start":"2026-02-06T05:59:14.351877Z","end":"2026-02-06T05:59:14.549352Z","steps":["trace[1181230744] 'agreement among raft nodes before linearized reading' (duration: 197.390547ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:14.549426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.479108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:59:14.549437Z","caller":"traceutil/trace.go:171","msg":"trace[740587500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:881; }","duration":"181.502648ms","start":"2026-02-06T05:59:14.367931Z","end":"2026-02-06T05:59:14.549434Z","steps":["trace[740587500] 'agreement among raft nodes before linearized reading' (duration: 181.467377ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:14.549642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.338711ms","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-02-06T05:59:14.549828Z","caller":"traceutil/trace.go:171","msg":"trace[635773404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:881; }","duration":"175.557148ms","start":"2026-02-06T05:59:14.374252Z","end":"2026-02-06T05:59:14.549809Z","steps":["trace[635773404] 'agreement among raft nodes before linearized reading' (duration: 175.260399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:14.899404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.803329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-06T05:59:14.899598Z","caller":"traceutil/trace.go:171","msg":"trace[1676533100] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"345.445216ms","start":"2026-02-06T05:59:14.554133Z","end":"2026-02-06T05:59:14.899579Z","steps":["trace[1676533100] 'process raft request' (duration: 103.373568ms)","trace[1676533100] 'compare' (duration: 241.707646ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:59:14.89966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:59:14.554129Z","time spent":"345.500297ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:59:14.89968Z","caller":"traceutil/trace.go:171","msg":"trace[608282049] linearizableReadLoop","detail":"{readStateIndex:917; appliedIndex:915; }","duration":"228.365458ms","start":"2026-02-06T05:59:14.671298Z","end":"2026-02-06T05:59:14.899663Z","steps":["trace[608282049] 'read index received' (duration: 22.47µs)","trace[608282049] 'applied index is now lower than readState.Index' (duration: 228.342228ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:59:14.899762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.447731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:59:14.899783Z","caller":"traceutil/trace.go:171","msg":"trace[1257173230] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:884; }","duration":"228.506103ms","start":"2026-02-06T05:59:14.67127Z","end":"2026-02-06T05:59:14.899776Z","steps":["trace[1257173230] 'agreement among raft nodes before linearized reading' (duration: 228.449141ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:14.899976Z","caller":"traceutil/trace.go:171","msg":"trace[1904652428] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"345.809087ms","start":"2026-02-06T05:59:14.554161Z","end":"2026-02-06T05:59:14.89997Z","steps":["trace[1904652428] 'process raft request' (duration: 345.338162ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:14.900026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:59:14.554158Z","time spent":"345.831578ms","remote":"127.0.0.1:55274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:59:15.849753Z","caller":"traceutil/trace.go:171","msg":"trace[273111398] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"142.798642ms","start":"2026-02-06T05:59:15.706932Z","end":"2026-02-06T05:59:15.849731Z","steps":["trace[273111398] 'process raft request' (duration: 142.669488ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:16.261981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.32142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:59:16.262052Z","caller":"traceutil/trace.go:171","msg":"trace[466370623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:886; }","duration":"144.433962ms","start":"2026-02-06T05:59:16.117601Z","end":"2026-02-06T05:59:16.262035Z","steps":["trace[466370623] 'range keys from in-memory index tree' (duration: 144.268577ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:18.391973Z","caller":"traceutil/trace.go:171","msg":"trace[1704145956] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"143.11324ms","start":"2026-02-06T05:59:18.248844Z","end":"2026-02-06T05:59:18.391957Z","steps":["trace[1704145956] 'process raft request' (duration: 133.7428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:18.797748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.906049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-06T05:59:18.797819Z","caller":"traceutil/trace.go:171","msg":"trace[289473974] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:900; }","duration":"236.023133ms","start":"2026-02-06T05:59:18.561778Z","end":"2026-02-06T05:59:18.797801Z","steps":["trace[289473974] 'range keys from in-memory index tree' (duration: 235.756934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:18.798055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.121458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-06T05:59:18.798084Z","caller":"traceutil/trace.go:171","msg":"trace[804233662] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:900; }","duration":"222.17275ms","start":"2026-02-06T05:59:18.575902Z","end":"2026-02-06T05:59:18.798075Z","steps":["trace[804233662] 'range keys from in-memory index tree' (duration: 222.036686ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:18.997464Z","caller":"traceutil/trace.go:171","msg":"trace[1333345184] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"193.619647ms","start":"2026-02-06T05:59:18.803824Z","end":"2026-02-06T05:59:18.997444Z","steps":["trace[1333345184] 'process raft request' (duration: 193.193453ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:19.032055Z","caller":"traceutil/trace.go:171","msg":"trace[1845552399] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:935; }","duration":"123.198562ms","start":"2026-02-06T05:59:18.908827Z","end":"2026-02-06T05:59:19.032026Z","steps":["trace[1845552399] 'read index received' (duration: 88.835463ms)","trace[1845552399] 'applied index is now lower than readState.Index' (duration: 34.362199ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:59:19.032234Z","caller":"traceutil/trace.go:171","msg":"trace[996191950] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"226.51365ms","start":"2026-02-06T05:59:18.805711Z","end":"2026-02-06T05:59:19.032224Z","steps":["trace[996191950] 'process raft request' (duration: 198.908856ms)","trace[996191950] 'compare' (duration: 27.18504ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:59:19.032473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.635897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:59:19.032498Z","caller":"traceutil/trace.go:171","msg":"trace[2017419781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:902; }","duration":"123.708529ms","start":"2026-02-06T05:59:18.908782Z","end":"2026-02-06T05:59:19.03249Z","steps":["trace[2017419781] 'agreement among raft nodes before linearized reading' (duration: 123.599906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:19.032622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.772869ms","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-02-06T05:59:19.03264Z","caller":"traceutil/trace.go:171","msg":"trace[1029099907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:902; }","duration":"122.821111ms","start":"2026-02-06T05:59:18.909814Z","end":"2026-02-06T05:59:19.032635Z","steps":["trace[1029099907] 'agreement among raft nodes before linearized reading' (duration: 122.768699ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:27.524386Z","caller":"traceutil/trace.go:171","msg":"trace[869592341] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"190.695873ms","start":"2026-02-06T05:59:27.333673Z","end":"2026-02-06T05:59:27.524369Z","steps":["trace[869592341] 'process raft request' (duration: 190.402603ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:32.74787Z","caller":"traceutil/trace.go:171","msg":"trace[249497901] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1033; }","duration":"127.820011ms","start":"2026-02-06T05:59:32.620033Z","end":"2026-02-06T05:59:32.747853Z","steps":["trace[249497901] 'read index received' (duration: 127.669006ms)","trace[249497901] 'applied index is now lower than readState.Index' (duration: 150.335µs)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:59:32.748168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.11036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-06T05:59:32.748265Z","caller":"traceutil/trace.go:171","msg":"trace[1044803388] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:997; }","duration":"128.247685ms","start":"2026-02-06T05:59:32.620009Z","end":"2026-02-06T05:59:32.748257Z","steps":["trace[1044803388] 'agreement among raft nodes before linearized reading' (duration: 128.067899ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:32.748459Z","caller":"traceutil/trace.go:171","msg":"trace[1755586693] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"209.117362ms","start":"2026-02-06T05:59:32.539323Z","end":"2026-02-06T05:59:32.748441Z","steps":["trace[1755586693] 'process raft request' (duration: 208.42962ms)"],"step_count":1}