{"level":"warn","ts":"2026-02-10T18:45:37.565234Z","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-10T18:45:37.56604Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.212: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.212:2380","--initial-cluster=instance=https://162.253.55.212:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.212:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.212: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-10T18:45:37.566195Z","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-10T18:45:37.566269Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.212:2380"]} {"level":"info","ts":"2026-02-10T18:45:37.568681Z","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-10T18:45:37.569294Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.212:2379"]} {"level":"info","ts":"2026-02-10T18:45:37.569422Z","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.212:2380"],"listen-peer-urls":["https://162.253.55.212:2380"],"advertise-client-urls":["https://162.253.55.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.212: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-10T18:45:37.57685Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.210848ms"} {"level":"info","ts":"2026-02-10T18:45:37.612019Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d078b1e39c21939c","cluster-id":"cdc9ba8de57e3589"} {"level":"info","ts":"2026-02-10T18:45:37.612115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=()"} {"level":"info","ts":"2026-02-10T18:45:37.61214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became follower at term 0"} {"level":"info","ts":"2026-02-10T18:45:37.612154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d078b1e39c21939c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-10T18:45:37.612182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became follower at term 1"} {"level":"info","ts":"2026-02-10T18:45:37.612228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=(15021952148229428124)"} {"level":"warn","ts":"2026-02-10T18:45:37.624678Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-10T18:45:37.629341Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-10T18:45:37.63214Z","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-10T18:45:37.636117Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d078b1e39c21939c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-10T18:45:37.63749Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d078b1e39c21939c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-10T18:45:37.63764Z","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-10T18:45:37.637672Z","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-10T18:45:37.637679Z","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-10T18:45:37.637951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=(15021952148229428124)"} {"level":"info","ts":"2026-02-10T18:45:37.638086Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdc9ba8de57e3589","local-member-id":"d078b1e39c21939c","added-peer-id":"d078b1e39c21939c","added-peer-peer-urls":["https://162.253.55.212:2380"]} {"level":"info","ts":"2026-02-10T18:45:37.645652Z","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-10T18:45:37.645854Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d078b1e39c21939c","initial-advertise-peer-urls":["https://162.253.55.212:2380"],"listen-peer-urls":["https://162.253.55.212:2380"],"advertise-client-urls":["https://162.253.55.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-10T18:45:37.645913Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-10T18:45:37.646034Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.212:2380"} {"level":"info","ts":"2026-02-10T18:45:37.646113Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.212:2380"} {"level":"info","ts":"2026-02-10T18:45:38.014392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c is starting a new election at term 1"} {"level":"info","ts":"2026-02-10T18:45:38.014429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became pre-candidate at term 1"} {"level":"info","ts":"2026-02-10T18:45:38.014496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c received MsgPreVoteResp from d078b1e39c21939c at term 1"} {"level":"info","ts":"2026-02-10T18:45:38.014508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became candidate at term 2"} {"level":"info","ts":"2026-02-10T18:45:38.014534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c received MsgVoteResp from d078b1e39c21939c at term 2"} {"level":"info","ts":"2026-02-10T18:45:38.014545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became leader at term 2"} {"level":"info","ts":"2026-02-10T18:45:38.014552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d078b1e39c21939c elected leader d078b1e39c21939c at term 2"} {"level":"info","ts":"2026-02-10T18:45:38.039813Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:45:38.04347Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d078b1e39c21939c","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.212:2379]}","request-path":"/0/members/d078b1e39c21939c/attributes","cluster-id":"cdc9ba8de57e3589","publish-timeout":"7s"} {"level":"info","ts":"2026-02-10T18:45:38.043555Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T18:45:38.0459Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.212:2379"} {"level":"info","ts":"2026-02-10T18:45:38.046516Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdc9ba8de57e3589","local-member-id":"d078b1e39c21939c","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:45:38.046822Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:45:38.046842Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:45:38.046852Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T18:45:38.052281Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-10T18:45:38.055235Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-10T18:45:38.055292Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-10T18:45:40.025633Z","caller":"traceutil/trace.go:171","msg":"trace[911609627] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"232.132856ms","start":"2026-02-10T18:45:39.793479Z","end":"2026-02-10T18:45:40.025612Z","steps":["trace[911609627] 'process raft request' (duration: 231.762893ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.026245Z","caller":"traceutil/trace.go:171","msg":"trace[30968303] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"218.492274ms","start":"2026-02-10T18:45:39.807741Z","end":"2026-02-10T18:45:40.026233Z","steps":["trace[30968303] 'process raft request' (duration: 217.680312ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.027397Z","caller":"traceutil/trace.go:171","msg":"trace[945093198] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"215.737426ms","start":"2026-02-10T18:45:39.811648Z","end":"2026-02-10T18:45:40.027385Z","steps":["trace[945093198] 'process raft request' (duration: 214.53377ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.02837Z","caller":"traceutil/trace.go:171","msg":"trace[939858606] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"215.789501ms","start":"2026-02-10T18:45:39.812569Z","end":"2026-02-10T18:45:40.028358Z","steps":["trace[939858606] 'process raft request' (duration: 214.643969ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.031408Z","caller":"traceutil/trace.go:171","msg":"trace[161193273] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"230.414827ms","start":"2026-02-10T18:45:39.800981Z","end":"2026-02-10T18:45:40.031396Z","steps":["trace[161193273] 'read index received' (duration: 56.124165ms)","trace[161193273] 'applied index is now lower than readState.Index' (duration: 174.289962ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:45:40.031573Z","caller":"traceutil/trace.go:171","msg":"trace[850458737] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"218.777165ms","start":"2026-02-10T18:45:39.812789Z","end":"2026-02-10T18:45:40.031566Z","steps":["trace[850458737] 'process raft request' (duration: 214.565622ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.031695Z","caller":"traceutil/trace.go:171","msg":"trace[1484907941] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"218.634232ms","start":"2026-02-10T18:45:39.813054Z","end":"2026-02-10T18:45:40.031688Z","steps":["trace[1484907941] 'process raft request' (duration: 215.271344ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.031796Z","caller":"traceutil/trace.go:171","msg":"trace[1469460235] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"218.157549ms","start":"2026-02-10T18:45:39.813633Z","end":"2026-02-10T18:45:40.03179Z","steps":["trace[1469460235] 'process raft request' (duration: 217.647254ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.031994Z","caller":"traceutil/trace.go:171","msg":"trace[683680812] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"182.149415ms","start":"2026-02-10T18:45:39.849838Z","end":"2026-02-10T18:45:40.031988Z","steps":["trace[683680812] 'process raft request' (duration: 181.537641ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.032141Z","caller":"traceutil/trace.go:171","msg":"trace[397548511] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"188.127681ms","start":"2026-02-10T18:45:39.844004Z","end":"2026-02-10T18:45:40.032132Z","steps":["trace[397548511] 'process raft request' (duration: 187.342591ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.03505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.93578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.035353Z","caller":"traceutil/trace.go:171","msg":"trace[1296576084] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"234.38727ms","start":"2026-02-10T18:45:39.800953Z","end":"2026-02-10T18:45:40.03534Z","steps":["trace[1296576084] 'agreement among raft nodes before linearized reading' (duration: 231.582812ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.110354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.606239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.110573Z","caller":"traceutil/trace.go:171","msg":"trace[274807993] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"169.833049ms","start":"2026-02-10T18:45:39.940705Z","end":"2026-02-10T18:45:40.110538Z","steps":["trace[274807993] 'agreement among raft nodes before linearized reading' (duration: 169.175901ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.111444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.88293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.114494Z","caller":"traceutil/trace.go:171","msg":"trace[834715036] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"178.964524ms","start":"2026-02-10T18:45:39.935511Z","end":"2026-02-10T18:45:40.114476Z","steps":["trace[834715036] 'agreement among raft nodes before linearized reading' (duration: 175.609116ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.112421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.401295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.119267Z","caller":"traceutil/trace.go:171","msg":"trace[225389805] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"252.356062ms","start":"2026-02-10T18:45:39.866882Z","end":"2026-02-10T18:45:40.119238Z","steps":["trace[225389805] 'agreement among raft nodes before linearized reading' (duration: 245.297246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.112799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.044535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.119566Z","caller":"traceutil/trace.go:171","msg":"trace[419418494] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"267.780393ms","start":"2026-02-10T18:45:39.851714Z","end":"2026-02-10T18:45:40.119494Z","steps":["trace[419418494] 'agreement among raft nodes before linearized reading' (duration: 260.808574ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.113215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.597007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.119842Z","caller":"traceutil/trace.go:171","msg":"trace[1292698068] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"306.187832ms","start":"2026-02-10T18:45:39.813575Z","end":"2026-02-10T18:45:40.119763Z","steps":["trace[1292698068] 'agreement among raft nodes before linearized reading' (duration: 299.564004ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.113388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.618113ms","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":"warn","ts":"2026-02-10T18:45:40.119967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:39.81357Z","time spent":"306.345275ms","remote":"127.0.0.1:45486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-02-10T18:45:40.120011Z","caller":"traceutil/trace.go:171","msg":"trace[1490367863] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:12; }","duration":"317.250432ms","start":"2026-02-10T18:45:39.80275Z","end":"2026-02-10T18:45:40.12Z","steps":["trace[1490367863] 'agreement among raft nodes before linearized reading' (duration: 310.495042ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.12016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:39.802743Z","time spent":"317.350831ms","remote":"127.0.0.1:45682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-02-10T18:45:40.114741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.564757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.212\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.12256Z","caller":"traceutil/trace.go:171","msg":"trace[483967694] range","detail":"{range_begin:/registry/masterleases/162.253.55.212; range_end:; response_count:0; response_revision:12; }","duration":"321.546344ms","start":"2026-02-10T18:45:39.801003Z","end":"2026-02-10T18:45:40.122549Z","steps":["trace[483967694] 'agreement among raft nodes before linearized reading' (duration: 312.415874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.122693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:39.800988Z","time spent":"321.595689ms","remote":"127.0.0.1:45624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/162.253.55.212\" "} {"level":"info","ts":"2026-02-10T18:45:40.247668Z","caller":"traceutil/trace.go:171","msg":"trace[1401328759] transaction","detail":"{read_only:false; number_of_response:0; response_revision:20; }","duration":"121.806449ms","start":"2026-02-10T18:45:40.12585Z","end":"2026-02-10T18:45:40.247657Z","steps":["trace[1401328759] 'process raft request' (duration: 121.793688ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.247812Z","caller":"traceutil/trace.go:171","msg":"trace[826713876] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"206.614665ms","start":"2026-02-10T18:45:40.041097Z","end":"2026-02-10T18:45:40.247712Z","steps":["trace[826713876] 'process raft request' (duration: 206.466352ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.248057Z","caller":"traceutil/trace.go:171","msg":"trace[45417842] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"206.904461ms","start":"2026-02-10T18:45:40.041145Z","end":"2026-02-10T18:45:40.24805Z","steps":["trace[45417842] 'process raft request' (duration: 206.430679ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.248196Z","caller":"traceutil/trace.go:171","msg":"trace[1468834855] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"212.871509ms","start":"2026-02-10T18:45:40.035309Z","end":"2026-02-10T18:45:40.248181Z","steps":["trace[1468834855] 'process raft request' (duration: 185.866863ms)","trace[1468834855] 'compare' (duration: 26.179323ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:45:40.248516Z","caller":"traceutil/trace.go:171","msg":"trace[1206472107] linearizableReadLoop","detail":"{readStateIndex:21; appliedIndex:15; }","duration":"138.678446ms","start":"2026-02-10T18:45:40.109822Z","end":"2026-02-10T18:45:40.248501Z","steps":["trace[1206472107] 'read index received' (duration: 111.363632ms)","trace[1206472107] 'applied index is now lower than readState.Index' (duration: 27.313364ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:45:40.248537Z","caller":"traceutil/trace.go:171","msg":"trace[796922095] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"207.611703ms","start":"2026-02-10T18:45:40.040913Z","end":"2026-02-10T18:45:40.248525Z","steps":["trace[796922095] 'process raft request' (duration: 206.576421ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.248842Z","caller":"traceutil/trace.go:171","msg":"trace[2135540914] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"207.813041ms","start":"2026-02-10T18:45:40.04101Z","end":"2026-02-10T18:45:40.248823Z","steps":["trace[2135540914] 'process raft request' (duration: 206.513356ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.249098Z","caller":"traceutil/trace.go:171","msg":"trace[438667575] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"207.966295ms","start":"2026-02-10T18:45:40.041088Z","end":"2026-02-10T18:45:40.249054Z","steps":["trace[438667575] 'process raft request' (duration: 206.459761ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.249429Z","caller":"traceutil/trace.go:171","msg":"trace[237582792] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"130.982894ms","start":"2026-02-10T18:45:40.118427Z","end":"2026-02-10T18:45:40.24941Z","steps":["trace[237582792] 'process raft request' (duration: 129.164692ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.249763Z","caller":"traceutil/trace.go:171","msg":"trace[20859602] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"123.945859ms","start":"2026-02-10T18:45:40.125804Z","end":"2026-02-10T18:45:40.24975Z","steps":["trace[20859602] 'process raft request' (duration: 121.82403ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.250028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.017508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-gc75w\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-02-10T18:45:40.250226Z","caller":"traceutil/trace.go:171","msg":"trace[156626055] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-gc75w; range_end:; response_count:1; response_revision:20; }","duration":"209.127048ms","start":"2026-02-10T18:45:40.040964Z","end":"2026-02-10T18:45:40.250091Z","steps":["trace[156626055] 'agreement among raft nodes before linearized reading' (duration: 208.798519ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.250674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.239264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3179"} {"level":"info","ts":"2026-02-10T18:45:40.25074Z","caller":"traceutil/trace.go:171","msg":"trace[213944169] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"125.323132ms","start":"2026-02-10T18:45:40.125406Z","end":"2026-02-10T18:45:40.250729Z","steps":["trace[213944169] 'agreement among raft nodes before linearized reading' (duration: 125.232034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.251534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.935605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.251598Z","caller":"traceutil/trace.go:171","msg":"trace[159380017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"126.009132ms","start":"2026-02-10T18:45:40.125578Z","end":"2026-02-10T18:45:40.251587Z","steps":["trace[159380017] 'agreement among raft nodes before linearized reading' (duration: 125.929155ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.409043Z","caller":"traceutil/trace.go:171","msg":"trace[321713336] linearizableReadLoop","detail":"{readStateIndex:30; appliedIndex:24; }","duration":"143.812111ms","start":"2026-02-10T18:45:40.265216Z","end":"2026-02-10T18:45:40.409028Z","steps":["trace[321713336] 'read index received' (duration: 18.155331ms)","trace[321713336] 'applied index is now lower than readState.Index' (duration: 125.65587ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:45:40.409299Z","caller":"traceutil/trace.go:171","msg":"trace[2101625558] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"144.590931ms","start":"2026-02-10T18:45:40.2647Z","end":"2026-02-10T18:45:40.40929Z","steps":["trace[2101625558] 'process raft request' (duration: 144.259901ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.409479Z","caller":"traceutil/trace.go:171","msg":"trace[77456141] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"144.197426ms","start":"2026-02-10T18:45:40.265275Z","end":"2026-02-10T18:45:40.409472Z","steps":["trace[77456141] 'process raft request' (duration: 143.715143ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.409618Z","caller":"traceutil/trace.go:171","msg":"trace[1622775035] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"144.008969ms","start":"2026-02-10T18:45:40.265602Z","end":"2026-02-10T18:45:40.409611Z","steps":["trace[1622775035] 'process raft request' (duration: 143.405106ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.409492Z","caller":"traceutil/trace.go:171","msg":"trace[2044548407] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"144.559978ms","start":"2026-02-10T18:45:40.264568Z","end":"2026-02-10T18:45:40.409128Z","steps":["trace[2044548407] 'process raft request' (duration: 144.375852ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.409834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.565929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.410179Z","caller":"traceutil/trace.go:171","msg":"trace[1300237715] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"146.585618ms","start":"2026-02-10T18:45:40.263587Z","end":"2026-02-10T18:45:40.410172Z","steps":["trace[1300237715] 'process raft request' (duration: 145.340388ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.411746Z","caller":"traceutil/trace.go:171","msg":"trace[314737586] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"148.491417ms","start":"2026-02-10T18:45:40.263244Z","end":"2026-02-10T18:45:40.411735Z","steps":["trace[314737586] 'process raft request' (duration: 105.976974ms)","trace[314737586] 'compare' (duration: 39.608695ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:45:40.411919Z","caller":"traceutil/trace.go:171","msg":"trace[822330376] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"148.40806ms","start":"2026-02-10T18:45:40.263498Z","end":"2026-02-10T18:45:40.411906Z","steps":["trace[822330376] 'process raft request' (duration: 145.402273ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.412959Z","caller":"traceutil/trace.go:171","msg":"trace[2075549722] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:28; }","duration":"145.000207ms","start":"2026-02-10T18:45:40.265193Z","end":"2026-02-10T18:45:40.410193Z","steps":["trace[2075549722] 'agreement among raft nodes before linearized reading' (duration: 144.542446ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.409874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.620813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.413085Z","caller":"traceutil/trace.go:171","msg":"trace[1229602411] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:28; }","duration":"147.804425ms","start":"2026-02-10T18:45:40.265248Z","end":"2026-02-10T18:45:40.413053Z","steps":["trace[1229602411] 'agreement among raft nodes before linearized reading' (duration: 144.611252ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.625452Z","caller":"traceutil/trace.go:171","msg":"trace[34251709] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"128.225019ms","start":"2026-02-10T18:45:40.497215Z","end":"2026-02-10T18:45:40.62544Z","steps":["trace[34251709] 'process raft request' (duration: 54.663941ms)","trace[34251709] 'compare' (duration: 73.488171ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:45:40.626245Z","caller":"traceutil/trace.go:171","msg":"trace[1007669446] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"126.376024ms","start":"2026-02-10T18:45:40.499864Z","end":"2026-02-10T18:45:40.62624Z","steps":["trace[1007669446] 'process raft request' (duration: 126.345212ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.626509Z","caller":"traceutil/trace.go:171","msg":"trace[1305743430] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"127.044804ms","start":"2026-02-10T18:45:40.499458Z","end":"2026-02-10T18:45:40.626502Z","steps":["trace[1305743430] 'process raft request' (duration: 125.953567ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.816027Z","caller":"traceutil/trace.go:171","msg":"trace[1571379551] linearizableReadLoop","detail":"{readStateIndex:53; appliedIndex:51; }","duration":"109.514978ms","start":"2026-02-10T18:45:40.706479Z","end":"2026-02-10T18:45:40.815993Z","steps":["trace[1571379551] 'read index received' (duration: 3.742322ms)","trace[1571379551] 'applied index is now lower than readState.Index' (duration: 105.771326ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:45:40.816562Z","caller":"traceutil/trace.go:171","msg":"trace[2055098859] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"111.754367ms","start":"2026-02-10T18:45:40.704786Z","end":"2026-02-10T18:45:40.81654Z","steps":["trace[2055098859] 'process raft request' (duration: 111.106359ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:40.817003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.505926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-10T18:45:40.817474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.985706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-cluster-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T18:45:40.817638Z","caller":"traceutil/trace.go:171","msg":"trace[292570437] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"112.059334ms","start":"2026-02-10T18:45:40.704753Z","end":"2026-02-10T18:45:40.816813Z","steps":["trace[292570437] 'process raft request' (duration: 72.23658ms)","trace[292570437] 'compare' (duration: 38.704345ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:45:40.817912Z","caller":"traceutil/trace.go:171","msg":"trace[48994561] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:49; }","duration":"110.613096ms","start":"2026-02-10T18:45:40.706434Z","end":"2026-02-10T18:45:40.817047Z","steps":["trace[48994561] 'agreement among raft nodes before linearized reading' (duration: 110.509436ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:40.818374Z","caller":"traceutil/trace.go:171","msg":"trace[1102966710] range","detail":"{range_begin:/registry/priorityclasses/system-cluster-critical; range_end:; response_count:0; response_revision:49; }","duration":"105.068313ms","start":"2026-02-10T18:45:40.71245Z","end":"2026-02-10T18:45:40.817519Z","steps":["trace[1102966710] 'agreement among raft nodes before linearized reading' (duration: 104.610043ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:41.301916Z","caller":"traceutil/trace.go:171","msg":"trace[1887477810] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"102.872678ms","start":"2026-02-10T18:45:41.199021Z","end":"2026-02-10T18:45:41.301894Z","steps":["trace[1887477810] 'process raft request' (duration: 40.489371ms)","trace[1887477810] 'compare' (duration: 62.216153ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:45:41.302564Z","caller":"traceutil/trace.go:171","msg":"trace[762142753] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"103.196736ms","start":"2026-02-10T18:45:41.199344Z","end":"2026-02-10T18:45:41.30254Z","steps":["trace[762142753] 'process raft request' (duration: 102.498275ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:44.480286Z","caller":"traceutil/trace.go:171","msg":"trace[807027943] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"300.766954ms","start":"2026-02-10T18:45:44.179496Z","end":"2026-02-10T18:45:44.480263Z","steps":["trace[807027943] 'process raft request' (duration: 300.72152ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:44.480878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:44.179487Z","time spent":"300.964181ms","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5860,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T18:45:44.48133Z","caller":"traceutil/trace.go:171","msg":"trace[1651669516] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"529.780958ms","start":"2026-02-10T18:45:43.95153Z","end":"2026-02-10T18:45:44.481311Z","steps":["trace[1651669516] 'process raft request' (duration: 511.568776ms)","trace[1651669516] 'compare' (duration: 15.897913ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:45:44.483469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:43.951504Z","time spent":"531.91432ms","remote":"127.0.0.1:45282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":184,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T18:45:44.481375Z","caller":"traceutil/trace.go:171","msg":"trace[1918986820] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:288; }","duration":"518.312996ms","start":"2026-02-10T18:45:43.963051Z","end":"2026-02-10T18:45:44.481364Z","steps":["trace[1918986820] 'read index received' (duration: 500.068912ms)","trace[1918986820] 'applied index is now lower than readState.Index' (duration: 18.243074ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:45:44.481515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.448068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:45:44.481553Z","caller":"traceutil/trace.go:171","msg":"trace[1955948901] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"434.119899ms","start":"2026-02-10T18:45:44.047425Z","end":"2026-02-10T18:45:44.481545Z","steps":["trace[1955948901] 'process raft request' (duration: 432.458226ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:44.481583Z","caller":"traceutil/trace.go:171","msg":"trace[1070884807] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"325.778968ms","start":"2026-02-10T18:45:44.155796Z","end":"2026-02-10T18:45:44.481575Z","steps":["trace[1070884807] 'process raft request' (duration: 324.130567ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:44.48161Z","caller":"traceutil/trace.go:171","msg":"trace[1793540001] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"307.706249ms","start":"2026-02-10T18:45:44.173897Z","end":"2026-02-10T18:45:44.481603Z","steps":["trace[1793540001] 'process raft request' (duration: 306.066798ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:44.481637Z","caller":"traceutil/trace.go:171","msg":"trace[402297160] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"305.97075ms","start":"2026-02-10T18:45:44.175659Z","end":"2026-02-10T18:45:44.48163Z","steps":["trace[402297160] 'process raft request' (duration: 304.445949ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:44.481687Z","caller":"traceutil/trace.go:171","msg":"trace[824865639] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"304.948092ms","start":"2026-02-10T18:45:44.176727Z","end":"2026-02-10T18:45:44.481675Z","steps":["trace[824865639] 'process raft request' (duration: 303.401359ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:44.481827Z","caller":"traceutil/trace.go:171","msg":"trace[773411965] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"302.453568ms","start":"2026-02-10T18:45:44.179362Z","end":"2026-02-10T18:45:44.481815Z","steps":["trace[773411965] 'process raft request' (duration: 300.807387ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:44.486213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:44.179354Z","time spent":"306.757257ms","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3943,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T18:45:44.486347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.860319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-10T18:45:44.489054Z","caller":"traceutil/trace.go:171","msg":"trace[2030247174] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:286; }","duration":"445.594343ms","start":"2026-02-10T18:45:44.043441Z","end":"2026-02-10T18:45:44.489035Z","steps":["trace[2030247174] 'agreement among raft nodes before linearized reading' (duration: 441.927218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:44.489213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:44.043428Z","time spent":"445.766308ms","remote":"127.0.0.1:45486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":688,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-02-10T18:45:44.486524Z","caller":"traceutil/trace.go:171","msg":"trace[963689676] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:286; }","duration":"523.478549ms","start":"2026-02-10T18:45:43.963024Z","end":"2026-02-10T18:45:44.486503Z","steps":["trace[963689676] 'agreement among raft nodes before linearized reading' (duration: 518.370451ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:44.48959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:43.963012Z","time spent":"526.561763ms","remote":"127.0.0.1:45552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "} {"level":"warn","ts":"2026-02-10T18:45:44.486648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:44.047406Z","time spent":"439.185423ms","remote":"127.0.0.1:45680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T18:45:44.486806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:44.155776Z","time spent":"331.005007ms","remote":"127.0.0.1:45246","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T18:45:44.486859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:44.173879Z","time spent":"312.950399ms","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T18:45:44.486892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:44.17564Z","time spent":"311.238431ms","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T18:45:44.486928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:44.176715Z","time spent":"310.196732ms","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T18:45:44.48715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.685142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:45:44.493459Z","caller":"traceutil/trace.go:171","msg":"trace[526156323] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:286; }","duration":"439.989672ms","start":"2026-02-10T18:45:44.053457Z","end":"2026-02-10T18:45:44.493446Z","steps":["trace[526156323] 'agreement among raft nodes before linearized reading' (duration: 433.654809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:44.493628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:44.053426Z","time spent":"440.18736ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-02-10T18:45:50.47497Z","caller":"traceutil/trace.go:171","msg":"trace[1454031159] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"536.865299ms","start":"2026-02-10T18:45:49.93805Z","end":"2026-02-10T18:45:50.474915Z","steps":["trace[1454031159] 'process raft request' (duration: 536.674843ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:50.476695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:49.938039Z","time spent":"537.037953ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:45:52.535213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.413012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:45:52.535336Z","caller":"traceutil/trace.go:171","msg":"trace[761171781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:398; }","duration":"422.563084ms","start":"2026-02-10T18:45:52.112755Z","end":"2026-02-10T18:45:52.535318Z","steps":["trace[761171781] 'range keys from in-memory index tree' (duration: 422.356098ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:52.535376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:52.112742Z","time spent":"422.622689ms","remote":"127.0.0.1:45588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T18:45:52.535434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.638004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6897"} {"level":"info","ts":"2026-02-10T18:45:52.535459Z","caller":"traceutil/trace.go:171","msg":"trace[46410798] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:398; }","duration":"415.688508ms","start":"2026-02-10T18:45:52.119762Z","end":"2026-02-10T18:45:52.53545Z","steps":["trace[46410798] 'range keys from in-memory index tree' (duration: 415.58057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:52.535484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:45:52.119734Z","time spent":"415.744052ms","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6921,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-02-10T18:45:52.535658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.684056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.212\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-10T18:45:52.53573Z","caller":"traceutil/trace.go:171","msg":"trace[1731510955] range","detail":"{range_begin:/registry/masterleases/162.253.55.212; range_end:; response_count:1; response_revision:398; }","duration":"172.779425ms","start":"2026-02-10T18:45:52.362939Z","end":"2026-02-10T18:45:52.535718Z","steps":["trace[1731510955] 'range keys from in-memory index tree' (duration: 172.626912ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:45:52.813583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.606889ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:45:52.813855Z","caller":"traceutil/trace.go:171","msg":"trace[671686630] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"246.594711ms","start":"2026-02-10T18:45:52.567229Z","end":"2026-02-10T18:45:52.813823Z","steps":["trace[671686630] 'process raft request' (duration: 75.525645ms)","trace[671686630] 'compare' (duration: 170.50282ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:45:52.813995Z","caller":"traceutil/trace.go:171","msg":"trace[1530369656] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"202.404478ms","start":"2026-02-10T18:45:52.611576Z","end":"2026-02-10T18:45:52.813981Z","steps":["trace[1530369656] 'process raft request' (duration: 202.250586ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:45:52.81432Z","caller":"traceutil/trace.go:171","msg":"trace[1126215049] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:413; }","duration":"204.844015ms","start":"2026-02-10T18:45:52.609467Z","end":"2026-02-10T18:45:52.814311Z","steps":["trace[1126215049] 'read index received' (duration: 33.29216ms)","trace[1126215049] 'applied index is now lower than readState.Index' (duration: 171.550925ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:45:52.814514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.052243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7237"} {"level":"info","ts":"2026-02-10T18:45:52.81584Z","caller":"traceutil/trace.go:171","msg":"trace[1089861462] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:402; }","duration":"206.395861ms","start":"2026-02-10T18:45:52.609434Z","end":"2026-02-10T18:45:52.81583Z","steps":["trace[1089861462] 'agreement among raft nodes before linearized reading' (duration: 205.008579ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:13.229587Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548256744788069,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:46:13.641135Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.276643047s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T18:46:13.641536Z","caller":"traceutil/trace.go:171","msg":"trace[1974074487] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"912.530042ms","start":"2026-02-10T18:46:12.728979Z","end":"2026-02-10T18:46:13.641509Z","steps":["trace[1974074487] 'read index received' (duration: 912.335541ms)","trace[1974074487] 'applied index is now lower than readState.Index' (duration: 193.171µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:46:13.64154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:12.364423Z","time spent":"1.277108722s","remote":"127.0.0.1:45624","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-10T18:46:13.641681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.673589ms","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-10T18:46:13.641717Z","caller":"traceutil/trace.go:171","msg":"trace[1960119884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"912.755554ms","start":"2026-02-10T18:46:12.728948Z","end":"2026-02-10T18:46:13.641704Z","steps":["trace[1960119884] 'agreement among raft nodes before linearized reading' (duration: 912.657859ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:13.641754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:12.728934Z","time spent":"912.810067ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T18:46:13.641912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.775342ms","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-10T18:46:13.64194Z","caller":"traceutil/trace.go:171","msg":"trace[652140122] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"744.837256ms","start":"2026-02-10T18:46:12.897091Z","end":"2026-02-10T18:46:13.641928Z","steps":["trace[652140122] 'agreement among raft nodes before linearized reading' (duration: 744.765352ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:13.64196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:12.897055Z","time spent":"744.901699ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T18:46:13.64212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.165634ms","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-10T18:46:13.642154Z","caller":"traceutil/trace.go:171","msg":"trace[1817956795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"590.226918ms","start":"2026-02-10T18:46:13.051917Z","end":"2026-02-10T18:46:13.642144Z","steps":["trace[1817956795] 'agreement among raft nodes before linearized reading' (duration: 590.121672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:13.64216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.692727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-10T18:46:13.642183Z","caller":"traceutil/trace.go:171","msg":"trace[1411819592] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:515; }","duration":"407.74768ms","start":"2026-02-10T18:46:13.234431Z","end":"2026-02-10T18:46:13.642179Z","steps":["trace[1411819592] 'agreement among raft nodes before linearized reading' (duration: 407.671956ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:13.642183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:13.051902Z","time spent":"590.274231ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:46:13.642198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:13.234413Z","time spent":"407.780822ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T18:46:14.607341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.595982ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:46:14.607547Z","caller":"traceutil/trace.go:171","msg":"trace[1639413955] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:533; }","duration":"495.301744ms","start":"2026-02-10T18:46:14.112232Z","end":"2026-02-10T18:46:14.607534Z","steps":["trace[1639413955] 'read index received' (duration: 202.451791ms)","trace[1639413955] 'applied index is now lower than readState.Index' (duration: 292.849383ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:46:14.607601Z","caller":"traceutil/trace.go:171","msg":"trace[1485136090] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"963.335893ms","start":"2026-02-10T18:46:13.644258Z","end":"2026-02-10T18:46:14.607593Z","steps":["trace[1485136090] 'process raft request' (duration: 670.436686ms)","trace[1485136090] 'compare' (duration: 292.427782ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:46:14.607631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:13.644244Z","time spent":"963.370132ms","remote":"127.0.0.1:45624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:46:14.607793Z","caller":"traceutil/trace.go:171","msg":"trace[1007076878] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"961.984219ms","start":"2026-02-10T18:46:13.645804Z","end":"2026-02-10T18:46:14.607788Z","steps":["trace[1007076878] 'process raft request' (duration: 961.612623ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:14.60782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:13.645785Z","time spent":"962.018958ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:46:14.607876Z","caller":"traceutil/trace.go:171","msg":"trace[1043838364] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"961.566173ms","start":"2026-02-10T18:46:13.646306Z","end":"2026-02-10T18:46:14.607872Z","steps":["trace[1043838364] 'process raft request' (duration: 961.178519ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:14.607897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:13.646299Z","time spent":"961.586202ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:46:14.607947Z","caller":"traceutil/trace.go:171","msg":"trace[1785219586] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"960.162617ms","start":"2026-02-10T18:46:13.64778Z","end":"2026-02-10T18:46:14.607943Z","steps":["trace[1785219586] 'process raft request' (duration: 959.721559ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:14.607968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:13.647774Z","time spent":"960.182096ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:46:14.608016Z","caller":"traceutil/trace.go:171","msg":"trace[444321743] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"960.200008ms","start":"2026-02-10T18:46:13.647813Z","end":"2026-02-10T18:46:14.608013Z","steps":["trace[444321743] 'process raft request' (duration: 959.704176ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:14.608036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:13.647809Z","time spent":"960.216516ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:46:14.608112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.880417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:46:14.608124Z","caller":"traceutil/trace.go:171","msg":"trace[492343592] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"495.925191ms","start":"2026-02-10T18:46:14.112195Z","end":"2026-02-10T18:46:14.60812Z","steps":["trace[492343592] 'agreement among raft nodes before linearized reading' (duration: 495.900914ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:14.608137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:14.112177Z","time spent":"495.957018ms","remote":"127.0.0.1:45578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T18:46:14.608206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.860076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:46:14.608219Z","caller":"traceutil/trace.go:171","msg":"trace[2006293398] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:520; }","duration":"115.90566ms","start":"2026-02-10T18:46:14.492308Z","end":"2026-02-10T18:46:14.608214Z","steps":["trace[2006293398] 'agreement among raft nodes before linearized reading' (duration: 115.886332ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:22.101299Z","caller":"traceutil/trace.go:171","msg":"trace[2048347567] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"905.257367ms","start":"2026-02-10T18:46:21.19602Z","end":"2026-02-10T18:46:22.101278Z","steps":["trace[2048347567] 'process raft request' (duration: 905.134629ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:22.101432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:21.196005Z","time spent":"905.368867ms","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:46:22.139092Z","caller":"traceutil/trace.go:171","msg":"trace[1530447134] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"821.491838ms","start":"2026-02-10T18:46:21.31757Z","end":"2026-02-10T18:46:22.139062Z","steps":["trace[1530447134] 'process raft request' (duration: 821.406096ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:22.139227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:21.31755Z","time spent":"821.610276ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:46:22.979954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.570184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.212\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-10T18:46:22.980037Z","caller":"traceutil/trace.go:171","msg":"trace[2009974419] range","detail":"{range_begin:/registry/masterleases/162.253.55.212; range_end:; response_count:1; response_revision:560; }","duration":"435.667724ms","start":"2026-02-10T18:46:22.544336Z","end":"2026-02-10T18:46:22.980003Z","steps":["trace[2009974419] 'range keys from in-memory index tree' (duration: 435.449315ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:22.980089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:22.544322Z","time spent":"435.755116ms","remote":"127.0.0.1:45624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.212\" "} {"level":"warn","ts":"2026-02-10T18:46:22.980297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.827479ms","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-10T18:46:22.980316Z","caller":"traceutil/trace.go:171","msg":"trace[1470739011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:560; }","duration":"346.872506ms","start":"2026-02-10T18:46:22.633438Z","end":"2026-02-10T18:46:22.980311Z","steps":["trace[1470739011] 'range keys from in-memory index tree' (duration: 346.769885ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:22.980334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:22.633424Z","time spent":"346.904472ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T18:46:22.980435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.338611ms","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-10T18:46:22.980453Z","caller":"traceutil/trace.go:171","msg":"trace[997987061] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:560; }","duration":"331.356129ms","start":"2026-02-10T18:46:22.649091Z","end":"2026-02-10T18:46:22.980447Z","steps":["trace[997987061] 'range keys from in-memory index tree' (duration: 331.286406ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:22.980468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:22.649029Z","time spent":"331.436051ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T18:46:22.980568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.727392ms","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-02-10T18:46:22.980584Z","caller":"traceutil/trace.go:171","msg":"trace[1720360408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:560; }","duration":"325.774057ms","start":"2026-02-10T18:46:22.654805Z","end":"2026-02-10T18:46:22.980579Z","steps":["trace[1720360408] 'range keys from in-memory index tree' (duration: 325.642281ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:22.980601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:22.65479Z","time spent":"325.807724ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:46:22.980694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.839947ms","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-10T18:46:22.980711Z","caller":"traceutil/trace.go:171","msg":"trace[1442070900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:560; }","duration":"323.866045ms","start":"2026-02-10T18:46:22.65684Z","end":"2026-02-10T18:46:22.980706Z","steps":["trace[1442070900] 'range keys from in-memory index tree' (duration: 323.799102ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:22.98073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:22.656835Z","time spent":"323.887123ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-10T18:46:23.210361Z","caller":"traceutil/trace.go:171","msg":"trace[24621936] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"220.867115ms","start":"2026-02-10T18:46:22.989475Z","end":"2026-02-10T18:46:23.210342Z","steps":["trace[24621936] 'process raft request' (duration: 220.768574ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:23.372321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:23.011438Z","time spent":"360.879709ms","remote":"127.0.0.1:45624","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-10T18:46:23.372889Z","caller":"traceutil/trace.go:171","msg":"trace[1699230292] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"360.469279ms","start":"2026-02-10T18:46:23.012404Z","end":"2026-02-10T18:46:23.372874Z","steps":["trace[1699230292] 'process raft request' (duration: 359.851828ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:23.373041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:23.012395Z","time spent":"360.517424ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:46:23.373423Z","caller":"traceutil/trace.go:171","msg":"trace[1940874548] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"358.606068ms","start":"2026-02-10T18:46:23.01481Z","end":"2026-02-10T18:46:23.373416Z","steps":["trace[1940874548] 'process raft request' (duration: 357.887767ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:23.373467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:23.014801Z","time spent":"358.642615ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:46:23.373895Z","caller":"traceutil/trace.go:171","msg":"trace[2035884978] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:581; }","duration":"260.360459ms","start":"2026-02-10T18:46:23.112982Z","end":"2026-02-10T18:46:23.373343Z","steps":["trace[2035884978] 'read index received' (duration: 97.693693ms)","trace[2035884978] 'applied index is now lower than readState.Index' (duration: 162.664826ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:46:23.373938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.952262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:46:23.373956Z","caller":"traceutil/trace.go:171","msg":"trace[939603778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"261.003148ms","start":"2026-02-10T18:46:23.112947Z","end":"2026-02-10T18:46:23.37395Z","steps":["trace[939603778] 'agreement among raft nodes before linearized reading' (duration: 260.971231ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:23.374059Z","caller":"traceutil/trace.go:171","msg":"trace[2085609638] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"358.217926ms","start":"2026-02-10T18:46:23.015834Z","end":"2026-02-10T18:46:23.374052Z","steps":["trace[2085609638] 'process raft request' (duration: 356.889003ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:23.374124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:23.015828Z","time spent":"358.252902ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:46:25.400198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286384578s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:46:25.4006Z","caller":"traceutil/trace.go:171","msg":"trace[244880852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"1.286875213s","start":"2026-02-10T18:46:24.113672Z","end":"2026-02-10T18:46:25.400548Z","steps":["trace[244880852] 'range keys from in-memory index tree' (duration: 1.286312705s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:25.400729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:24.113655Z","time spent":"1.287059846s","remote":"127.0.0.1:45578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T18:46:25.401171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.373475ms","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-10T18:46:25.401231Z","caller":"traceutil/trace.go:171","msg":"trace[1998412960] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:565; }","duration":"187.468747ms","start":"2026-02-10T18:46:25.213749Z","end":"2026-02-10T18:46:25.401218Z","steps":["trace[1998412960] 'range keys from in-memory index tree' (duration: 187.246257ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:25.528599Z","caller":"traceutil/trace.go:171","msg":"trace[1851039931] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:586; }","duration":"113.038219ms","start":"2026-02-10T18:46:25.415539Z","end":"2026-02-10T18:46:25.528578Z","steps":["trace[1851039931] 'read index received' (duration: 60.54764ms)","trace[1851039931] 'applied index is now lower than readState.Index' (duration: 52.489849ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:46:25.528745Z","caller":"traceutil/trace.go:171","msg":"trace[1372679992] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"113.931887ms","start":"2026-02-10T18:46:25.414773Z","end":"2026-02-10T18:46:25.528705Z","steps":["trace[1372679992] 'process raft request' (duration: 113.619966ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:25.529008Z","caller":"traceutil/trace.go:171","msg":"trace[1763754820] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"112.176708ms","start":"2026-02-10T18:46:25.416824Z","end":"2026-02-10T18:46:25.529001Z","steps":["trace[1763754820] 'process raft request' (duration: 111.726239ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:25.529126Z","caller":"traceutil/trace.go:171","msg":"trace[1533152972] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"112.498359ms","start":"2026-02-10T18:46:25.416621Z","end":"2026-02-10T18:46:25.52912Z","steps":["trace[1533152972] 'process raft request' (duration: 111.874646ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:25.52922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.659022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:46:25.529246Z","caller":"traceutil/trace.go:171","msg":"trace[2117379237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"113.727666ms","start":"2026-02-10T18:46:25.415511Z","end":"2026-02-10T18:46:25.529238Z","steps":["trace[2117379237] 'agreement among raft nodes before linearized reading' (duration: 113.668671ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:27.689992Z","caller":"traceutil/trace.go:171","msg":"trace[471657975] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"157.462738ms","start":"2026-02-10T18:46:27.532514Z","end":"2026-02-10T18:46:27.689977Z","steps":["trace[471657975] 'read index received' (duration: 157.350588ms)","trace[471657975] 'applied index is now lower than readState.Index' (duration: 111.54µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:46:27.690068Z","caller":"traceutil/trace.go:171","msg":"trace[1312489186] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"207.915325ms","start":"2026-02-10T18:46:27.482148Z","end":"2026-02-10T18:46:27.690063Z","steps":["trace[1312489186] 'process raft request' (duration: 207.721942ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:27.690205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.678978ms","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-10T18:46:27.690221Z","caller":"traceutil/trace.go:171","msg":"trace[1796580661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"157.732284ms","start":"2026-02-10T18:46:27.532484Z","end":"2026-02-10T18:46:27.690216Z","steps":["trace[1796580661] 'agreement among raft nodes before linearized reading' (duration: 157.659031ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:27.690418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.10095ms","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-02-10T18:46:27.690432Z","caller":"traceutil/trace.go:171","msg":"trace[911628453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"157.126438ms","start":"2026-02-10T18:46:27.533301Z","end":"2026-02-10T18:46:27.690428Z","steps":["trace[911628453] 'agreement among raft nodes before linearized reading' (duration: 157.087771ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:27.690443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.540901ms","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-10T18:46:27.690509Z","caller":"traceutil/trace.go:171","msg":"trace[1322030749] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"157.609775ms","start":"2026-02-10T18:46:27.53287Z","end":"2026-02-10T18:46:27.69048Z","steps":["trace[1322030749] 'agreement among raft nodes before linearized reading' (duration: 157.451239ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:28.051899Z","caller":"traceutil/trace.go:171","msg":"trace[1750688928] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"357.897243ms","start":"2026-02-10T18:46:27.693985Z","end":"2026-02-10T18:46:28.051882Z","steps":["trace[1750688928] 'process raft request' (duration: 357.796441ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:28.051994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:27.693973Z","time spent":"357.971046ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:46:28.055267Z","caller":"traceutil/trace.go:171","msg":"trace[415742512] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"361.140556ms","start":"2026-02-10T18:46:27.694115Z","end":"2026-02-10T18:46:28.055256Z","steps":["trace[415742512] 'process raft request' (duration: 361.061993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:28.055359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:27.694108Z","time spent":"361.189512ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:46:28.055389Z","caller":"traceutil/trace.go:171","msg":"trace[1727696763] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"360.451126ms","start":"2026-02-10T18:46:27.694912Z","end":"2026-02-10T18:46:28.055363Z","steps":["trace[1727696763] 'process raft request' (duration: 360.321467ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:28.055439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:27.694906Z","time spent":"360.507222ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:46:29.853767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.891176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:46:29.853843Z","caller":"traceutil/trace.go:171","msg":"trace[321419775] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"157.700939ms","start":"2026-02-10T18:46:29.696132Z","end":"2026-02-10T18:46:29.853832Z","steps":["trace[321419775] 'process raft request' (duration: 41.691632ms)","trace[321419775] 'compare' (duration: 115.810403ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:46:30.959054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.485174ms","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-10T18:46:30.959112Z","caller":"traceutil/trace.go:171","msg":"trace[1187618156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"903.587566ms","start":"2026-02-10T18:46:30.055511Z","end":"2026-02-10T18:46:30.959099Z","steps":["trace[1187618156] 'range keys from in-memory index tree' (duration: 903.354554ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:30.959137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:30.055494Z","time spent":"903.637031ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T18:46:30.959274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.135475ms","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-10T18:46:30.959301Z","caller":"traceutil/trace.go:171","msg":"trace[1969192245] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"901.167212ms","start":"2026-02-10T18:46:30.058126Z","end":"2026-02-10T18:46:30.959293Z","steps":["trace[1969192245] 'range keys from in-memory index tree' (duration: 901.093989ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:30.959323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:30.058123Z","time spent":"901.19457ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T18:46:30.959405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.298242ms","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-02-10T18:46:30.959429Z","caller":"traceutil/trace.go:171","msg":"trace[2138570178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"901.33113ms","start":"2026-02-10T18:46:30.058091Z","end":"2026-02-10T18:46:30.959422Z","steps":["trace[2138570178] 'range keys from in-memory index tree' (duration: 901.211929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:30.959447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:30.058086Z","time spent":"901.355187ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:46:30.959496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.494359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:46:30.959515Z","caller":"traceutil/trace.go:171","msg":"trace[200775257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"849.537106ms","start":"2026-02-10T18:46:30.109973Z","end":"2026-02-10T18:46:30.95951Z","steps":["trace[200775257] 'range keys from in-memory index tree' (duration: 849.461172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:30.959533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:30.109964Z","time spent":"849.564014ms","remote":"127.0.0.1:45578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T18:46:30.959675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.69864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-v9dhx\" ","response":"range_response_count:1 size:17171"} {"level":"info","ts":"2026-02-10T18:46:30.959698Z","caller":"traceutil/trace.go:171","msg":"trace[856846730] range","detail":"{range_begin:/registry/pods/kube-system/cilium-v9dhx; range_end:; response_count:1; response_revision:584; }","duration":"738.754635ms","start":"2026-02-10T18:46:30.220938Z","end":"2026-02-10T18:46:30.959693Z","steps":["trace[856846730] 'range keys from in-memory index tree' (duration: 738.590918ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:30.959717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:30.220925Z","time spent":"738.786752ms","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17195,"request content":"key:\"/registry/pods/kube-system/cilium-v9dhx\" "} {"level":"info","ts":"2026-02-10T18:46:31.822326Z","caller":"traceutil/trace.go:171","msg":"trace[750230723] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"198.778616ms","start":"2026-02-10T18:46:31.623511Z","end":"2026-02-10T18:46:31.822289Z","steps":["trace[750230723] 'process raft request' (duration: 161.310823ms)","trace[750230723] 'compare' (duration: 36.984481ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:46:31.882435Z","caller":"traceutil/trace.go:171","msg":"trace[898884647] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"255.242749ms","start":"2026-02-10T18:46:31.627186Z","end":"2026-02-10T18:46:31.882428Z","steps":["trace[898884647] 'process raft request' (duration: 255.11097ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:31.88241Z","caller":"traceutil/trace.go:171","msg":"trace[1957544081] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"201.381148ms","start":"2026-02-10T18:46:31.681017Z","end":"2026-02-10T18:46:31.882398Z","steps":["trace[1957544081] 'process raft request' (duration: 201.36143ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:31.991495Z","caller":"traceutil/trace.go:171","msg":"trace[925960774] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:623; }","duration":"134.531731ms","start":"2026-02-10T18:46:31.856942Z","end":"2026-02-10T18:46:31.991474Z","steps":["trace[925960774] 'read index received' (duration: 25.406111ms)","trace[925960774] 'applied index is now lower than readState.Index' (duration: 109.12466ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:46:31.992029Z","caller":"traceutil/trace.go:171","msg":"trace[1352360538] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"164.088152ms","start":"2026-02-10T18:46:31.827924Z","end":"2026-02-10T18:46:31.992012Z","steps":["trace[1352360538] 'process raft request' (duration: 122.671183ms)","trace[1352360538] 'compare' (duration: 40.794058ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:46:31.993373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.42797ms","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-10T18:46:31.99342Z","caller":"traceutil/trace.go:171","msg":"trace[389034509] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"136.507514ms","start":"2026-02-10T18:46:31.856901Z","end":"2026-02-10T18:46:31.993409Z","steps":["trace[389034509] 'agreement among raft nodes before linearized reading' (duration: 136.372035ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:31.99874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.525683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:46:31.99879Z","caller":"traceutil/trace.go:171","msg":"trace[165199902] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:606; }","duration":"119.621685ms","start":"2026-02-10T18:46:31.879156Z","end":"2026-02-10T18:46:31.998778Z","steps":["trace[165199902] 'agreement among raft nodes before linearized reading' (duration: 119.528203ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:31.998967Z","caller":"traceutil/trace.go:171","msg":"trace[485774118] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"112.321696ms","start":"2026-02-10T18:46:31.88664Z","end":"2026-02-10T18:46:31.998961Z","steps":["trace[485774118] 'process raft request' (duration: 111.941086ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:31.999095Z","caller":"traceutil/trace.go:171","msg":"trace[1687468538] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"111.075755ms","start":"2026-02-10T18:46:31.888012Z","end":"2026-02-10T18:46:31.999087Z","steps":["trace[1687468538] 'process raft request' (duration: 110.638549ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:32.111322Z","caller":"traceutil/trace.go:171","msg":"trace[1830706122] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"100.98001ms","start":"2026-02-10T18:46:32.010326Z","end":"2026-02-10T18:46:32.111306Z","steps":["trace[1830706122] 'process raft request' (duration: 89.781619ms)","trace[1830706122] 'compare' (duration: 10.918693ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:46:33.719242Z","caller":"traceutil/trace.go:171","msg":"trace[2095606923] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"236.91185ms","start":"2026-02-10T18:46:33.482316Z","end":"2026-02-10T18:46:33.719228Z","steps":["trace[2095606923] 'process raft request' (duration: 236.828326ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:33.719665Z","caller":"traceutil/trace.go:171","msg":"trace[1736536936] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:666; }","duration":"114.206802ms","start":"2026-02-10T18:46:33.605451Z","end":"2026-02-10T18:46:33.719658Z","steps":["trace[1736536936] 'read index received' (duration: 114.203522ms)","trace[1736536936] 'applied index is now lower than readState.Index' (duration: 2.8µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:46:33.71986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.396087ms","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-10T18:46:33.719921Z","caller":"traceutil/trace.go:171","msg":"trace[1516566789] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:643; }","duration":"114.463893ms","start":"2026-02-10T18:46:33.605412Z","end":"2026-02-10T18:46:33.719876Z","steps":["trace[1516566789] 'agreement among raft nodes before linearized reading' (duration: 114.300645ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:39.125991Z","caller":"traceutil/trace.go:171","msg":"trace[253621145] linearizableReadLoop","detail":"{readStateIndex:722; appliedIndex:721; }","duration":"100.505319ms","start":"2026-02-10T18:46:39.025471Z","end":"2026-02-10T18:46:39.125976Z","steps":["trace[253621145] 'read index received' (duration: 85.721228ms)","trace[253621145] 'applied index is now lower than readState.Index' (duration: 14.783581ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:46:39.126204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.718105ms","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-02-10T18:46:39.126276Z","caller":"traceutil/trace.go:171","msg":"trace[2106175219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:697; }","duration":"100.809579ms","start":"2026-02-10T18:46:39.025456Z","end":"2026-02-10T18:46:39.126265Z","steps":["trace[2106175219] 'agreement among raft nodes before linearized reading' (duration: 100.64129ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:39.126307Z","caller":"traceutil/trace.go:171","msg":"trace[1792463491] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"105.609778ms","start":"2026-02-10T18:46:39.02069Z","end":"2026-02-10T18:46:39.1263Z","steps":["trace[1792463491] 'process raft request' (duration: 90.543926ms)","trace[1792463491] 'compare' (duration: 14.511418ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:46:40.028244Z","caller":"traceutil/trace.go:171","msg":"trace[517611418] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"109.244748ms","start":"2026-02-10T18:46:39.918976Z","end":"2026-02-10T18:46:40.02822Z","steps":["trace[517611418] 'process raft request' (duration: 109.010933ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:40.320011Z","caller":"traceutil/trace.go:171","msg":"trace[1426740955] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"130.285377ms","start":"2026-02-10T18:46:40.18971Z","end":"2026-02-10T18:46:40.319995Z","steps":["trace[1426740955] 'process raft request' (duration: 130.187764ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:42.517052Z","caller":"traceutil/trace.go:171","msg":"trace[2062100708] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"118.979216ms","start":"2026-02-10T18:46:42.398053Z","end":"2026-02-10T18:46:42.517032Z","steps":["trace[2062100708] 'process raft request' (duration: 118.807417ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:45.328223Z","caller":"traceutil/trace.go:171","msg":"trace[1384884213] linearizableReadLoop","detail":"{readStateIndex:795; appliedIndex:794; }","duration":"167.672632ms","start":"2026-02-10T18:46:45.160525Z","end":"2026-02-10T18:46:45.328197Z","steps":["trace[1384884213] 'read index received' (duration: 92.600749ms)","trace[1384884213] 'applied index is now lower than readState.Index' (duration: 75.070593ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:46:45.328316Z","caller":"traceutil/trace.go:171","msg":"trace[726346793] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"175.441544ms","start":"2026-02-10T18:46:45.152855Z","end":"2026-02-10T18:46:45.328297Z","steps":["trace[726346793] 'process raft request' (duration: 100.319953ms)","trace[726346793] 'compare' (duration: 74.880014ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:46:45.32841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.865602ms","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-02-10T18:46:45.328444Z","caller":"traceutil/trace.go:171","msg":"trace[618226861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:768; }","duration":"167.931807ms","start":"2026-02-10T18:46:45.160501Z","end":"2026-02-10T18:46:45.328433Z","steps":["trace[618226861] 'agreement among raft nodes before linearized reading' (duration: 167.781425ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:46.265556Z","caller":"traceutil/trace.go:171","msg":"trace[1432402701] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"189.317302ms","start":"2026-02-10T18:46:46.076221Z","end":"2026-02-10T18:46:46.265538Z","steps":["trace[1432402701] 'process raft request' (duration: 187.1025ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:46.41793Z","caller":"traceutil/trace.go:171","msg":"trace[1561879027] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"107.859834ms","start":"2026-02-10T18:46:46.310053Z","end":"2026-02-10T18:46:46.417913Z","steps":["trace[1561879027] 'process raft request' (duration: 73.271516ms)","trace[1561879027] 'compare' (duration: 33.576432ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:46:48.664766Z","caller":"traceutil/trace.go:171","msg":"trace[1957895673] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"208.105791ms","start":"2026-02-10T18:46:48.456638Z","end":"2026-02-10T18:46:48.664744Z","steps":["trace[1957895673] 'process raft request' (duration: 207.975508ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:49.588002Z","caller":"traceutil/trace.go:171","msg":"trace[42042711] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"168.064473ms","start":"2026-02-10T18:46:49.419915Z","end":"2026-02-10T18:46:49.58798Z","steps":["trace[42042711] 'read index received' (duration: 167.881982ms)","trace[42042711] 'applied index is now lower than readState.Index' (duration: 181.631µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:46:49.588238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.300171ms","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-02-10T18:46:49.588276Z","caller":"traceutil/trace.go:171","msg":"trace[1924575875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:781; }","duration":"168.374718ms","start":"2026-02-10T18:46:49.419892Z","end":"2026-02-10T18:46:49.588266Z","steps":["trace[1924575875] 'agreement among raft nodes before linearized reading' (duration: 168.173008ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:46:49.58853Z","caller":"traceutil/trace.go:171","msg":"trace[1679464212] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"187.151756ms","start":"2026-02-10T18:46:49.401368Z","end":"2026-02-10T18:46:49.58852Z","steps":["trace[1679464212] 'process raft request' (duration: 186.484509ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:50.272018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.871007ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:46:50.272087Z","caller":"traceutil/trace.go:171","msg":"trace[821320870] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"161.922799ms","start":"2026-02-10T18:46:50.110151Z","end":"2026-02-10T18:46:50.272074Z","steps":["trace[821320870] 'read index received' (duration: 31.188µs)","trace[821320870] 'applied index is now lower than readState.Index' (duration: 161.890881ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:46:50.272247Z","caller":"traceutil/trace.go:171","msg":"trace[835450649] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"679.972912ms","start":"2026-02-10T18:46:49.592264Z","end":"2026-02-10T18:46:50.272237Z","steps":["trace[835450649] 'process raft request' (duration: 255.814398ms)","trace[835450649] 'compare' (duration: 423.60808ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:46:50.27229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:49.592251Z","time spent":"680.02024ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:46:50.2724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.253254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:46:50.272421Z","caller":"traceutil/trace.go:171","msg":"trace[1602213817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:782; }","duration":"162.299412ms","start":"2026-02-10T18:46:50.110116Z","end":"2026-02-10T18:46:50.272416Z","steps":["trace[1602213817] 'agreement among raft nodes before linearized reading' (duration: 162.264083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:50.272548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.050148ms","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-02-10T18:46:50.27257Z","caller":"traceutil/trace.go:171","msg":"trace[1204712301] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:782; }","duration":"105.073247ms","start":"2026-02-10T18:46:50.167491Z","end":"2026-02-10T18:46:50.272565Z","steps":["trace[1204712301] 'agreement among raft nodes before linearized reading' (duration: 105.00146ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:47:45.735936Z","caller":"traceutil/trace.go:171","msg":"trace[807318147] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"105.546156ms","start":"2026-02-10T18:47:45.630367Z","end":"2026-02-10T18:47:45.735914Z","steps":["trace[807318147] 'process raft request' (duration: 105.416585ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:47:46.155154Z","caller":"traceutil/trace.go:171","msg":"trace[1092118852] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"111.876757ms","start":"2026-02-10T18:47:46.043257Z","end":"2026-02-10T18:47:46.155134Z","steps":["trace[1092118852] 'process raft request' (duration: 111.586775ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:47:50.800598Z","caller":"traceutil/trace.go:171","msg":"trace[836504622] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"398.9505ms","start":"2026-02-10T18:47:50.40163Z","end":"2026-02-10T18:47:50.80058Z","steps":["trace[836504622] 'read index received' (duration: 398.802869ms)","trace[836504622] 'applied index is now lower than readState.Index' (duration: 146.651µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:50.801237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.589418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:47:50.801282Z","caller":"traceutil/trace.go:171","msg":"trace[1057015028] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:998; }","duration":"102.853711ms","start":"2026-02-10T18:47:50.698412Z","end":"2026-02-10T18:47:50.801266Z","steps":["trace[1057015028] 'agreement among raft nodes before linearized reading' (duration: 102.552378ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:47:50.801648Z","caller":"traceutil/trace.go:171","msg":"trace[1131143602] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"413.834652ms","start":"2026-02-10T18:47:50.387796Z","end":"2026-02-10T18:47:50.801631Z","steps":["trace[1131143602] 'process raft request' (duration: 412.680602ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:50.801706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:50.387781Z","time spent":"413.885902ms","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2572,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:47:50.802124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.489923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:47:50.805665Z","caller":"traceutil/trace.go:171","msg":"trace[1470157232] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:998; }","duration":"404.040721ms","start":"2026-02-10T18:47:50.401606Z","end":"2026-02-10T18:47:50.805647Z","steps":["trace[1470157232] 'agreement among raft nodes before linearized reading' (duration: 400.362251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:50.806301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:50.401596Z","time spent":"404.123112ms","remote":"127.0.0.1:45568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-02-10T18:47:51.321827Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548256744789204,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:47:51.821966Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548256744789204,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:47:52.322718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548256744789204,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:47:52.823258Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548256744789204,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:47:53.15999Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.349431734s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T18:47:53.162338Z","caller":"traceutil/trace.go:171","msg":"trace[1521785824] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"2.351844968s","start":"2026-02-10T18:47:50.810467Z","end":"2026-02-10T18:47:53.162312Z","steps":["trace[1521785824] 'process raft request' (duration: 2.349768878s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:53.162503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:50.810452Z","time spent":"2.351967099s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:47:53.524634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000641423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-10T18:47:53.524719Z","caller":"traceutil/trace.go:171","msg":"trace[1822261958] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001491011s","start":"2026-02-10T18:47:51.523203Z","end":"2026-02-10T18:47:53.524694Z","steps":["trace[1822261958] 'agreement among raft nodes before linearized reading' (duration: 2.000669303s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:53.524849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:51.523185Z","time spent":"2.001644543s","remote":"127.0.0.1:45578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/10 18:47:53 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-10T18:47:54.114108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000368069s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-10T18:47:54.114216Z","caller":"traceutil/trace.go:171","msg":"trace[1746097636] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00053464s","start":"2026-02-10T18:47:52.11366Z","end":"2026-02-10T18:47:54.114194Z","steps":["trace[1746097636] 'agreement among raft nodes before linearized reading' (duration: 2.000377669s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:54.114278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:52.113643Z","time spent":"2.000620551s","remote":"127.0.0.1:45588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T18:47:54.836397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.496659ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:47:54.836592Z","caller":"traceutil/trace.go:171","msg":"trace[1035494559] linearizableReadLoop","detail":"{readStateIndex:1043; appliedIndex:1040; }","duration":"4.015007379s","start":"2026-02-10T18:47:50.821569Z","end":"2026-02-10T18:47:54.836577Z","steps":["trace[1035494559] 'read index received' (duration: 2.338676778s)","trace[1035494559] 'applied index is now lower than readState.Index' (duration: 1.676329651s)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:47:54.836659Z","caller":"traceutil/trace.go:171","msg":"trace[961618584] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"4.018423797s","start":"2026-02-10T18:47:50.818223Z","end":"2026-02-10T18:47:54.836647Z","steps":["trace[961618584] 'process raft request' (duration: 3.560619695s)","trace[961618584] 'compare' (duration: 457.038774ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:54.836708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:50.818199Z","time spent":"4.018484567s","remote":"127.0.0.1:45680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T18:47:54.837348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.015757887s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2587"} {"level":"info","ts":"2026-02-10T18:47:54.837416Z","caller":"traceutil/trace.go:171","msg":"trace[1753162194] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1001; }","duration":"4.015851038s","start":"2026-02-10T18:47:50.821549Z","end":"2026-02-10T18:47:54.8374Z","steps":["trace[1753162194] 'agreement among raft nodes before linearized reading' (duration: 4.015633945s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:54.837453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:50.821534Z","time spent":"4.015910948s","remote":"127.0.0.1:45252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":2611,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"info","ts":"2026-02-10T18:47:54.837035Z","caller":"traceutil/trace.go:171","msg":"trace[117810128] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"4.015288152s","start":"2026-02-10T18:47:50.821736Z","end":"2026-02-10T18:47:54.837024Z","steps":["trace[117810128] 'process raft request' (duration: 4.014778386s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:54.839337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:50.821729Z","time spent":"4.017538915s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:47:56.12132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000242017s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-10T18:47:56.121585Z","caller":"traceutil/trace.go:171","msg":"trace[1488978157] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000532051s","start":"2026-02-10T18:47:54.121022Z","end":"2026-02-10T18:47:56.121554Z","steps":["trace[1488978157] 'agreement among raft nodes before linearized reading' (duration: 2.000266698s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:56.121663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:54.121005Z","time spent":"2.000628852s","remote":"127.0.0.1:45578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/10 18:47:56 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-10T18:47:56.254557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.001089037s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-10T18:47:56.25463Z","caller":"traceutil/trace.go:171","msg":"trace[1714301857] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.001205638s","start":"2026-02-10T18:47:51.253407Z","end":"2026-02-10T18:47:56.254613Z","steps":["trace[1714301857] 'agreement among raft nodes before linearized reading' (duration: 5.001111697s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:56.254869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:51.253393Z","time spent":"5.00134278s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T18:47:56.33787Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.24799299s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-10T18:47:56.861761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.997883925s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-10T18:47:56.862002Z","caller":"traceutil/trace.go:171","msg":"trace[464192017] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.998177797s","start":"2026-02-10T18:47:51.863801Z","end":"2026-02-10T18:47:56.861979Z","steps":["trace[464192017] 'agreement among raft nodes before linearized reading' (duration: 4.997918784s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:56.862428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:51.86378Z","time spent":"4.998630612s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T18:47:58.121925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000247482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-10T18:47:58.121996Z","caller":"traceutil/trace.go:171","msg":"trace[830621067] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000440145s","start":"2026-02-10T18:47:56.12154Z","end":"2026-02-10T18:47:58.12198Z","steps":["trace[830621067] 'agreement among raft nodes before linearized reading' (duration: 2.000342233s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:58.12204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:56.121521Z","time spent":"2.000509946s","remote":"127.0.0.1:45588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/10 18:47:58 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-10T18:47:58.321188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:55.058062Z","time spent":"3.263119306s","remote":"127.0.0.1:58410","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-10T18:47:58.321386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.088122802s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:47:58.321619Z","caller":"traceutil/trace.go:171","msg":"trace[1177346212] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1001; }","duration":"2.088366255s","start":"2026-02-10T18:47:56.233234Z","end":"2026-02-10T18:47:58.3216Z","steps":["trace[1177346212] 'range keys from in-memory index tree' (duration: 2.087994991s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:58.323696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.233607649s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:47:58.327838Z","caller":"traceutil/trace.go:171","msg":"trace[1454909708] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"3.955753637s","start":"2026-02-10T18:47:54.372064Z","end":"2026-02-10T18:47:58.327818Z","steps":["trace[1454909708] 'process raft request' (duration: 717.952226ms)","trace[1454909708] 'compare' (duration: 3.233011462s)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:58.328195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:54.37204Z","time spent":"3.955846998s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:47:58.328561Z","caller":"traceutil/trace.go:171","msg":"trace[1771840106] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1043; }","duration":"3.491921713s","start":"2026-02-10T18:47:54.83662Z","end":"2026-02-10T18:47:58.328542Z","steps":["trace[1771840106] 'read index received' (duration: 253.404653ms)","trace[1771840106] 'applied index is now lower than readState.Index' (duration: 3.23851561s)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:47:58.328669Z","caller":"traceutil/trace.go:171","msg":"trace[1951369271] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"3.484572977s","start":"2026-02-10T18:47:54.844081Z","end":"2026-02-10T18:47:58.328654Z","steps":["trace[1951369271] 'process raft request' (duration: 3.479679967s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:58.32885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:54.844067Z","time spent":"3.48470592s","remote":"127.0.0.1:45680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T18:47:58.329146Z","caller":"traceutil/trace.go:171","msg":"trace[1528318461] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"707.167497ms","start":"2026-02-10T18:47:57.62197Z","end":"2026-02-10T18:47:58.329137Z","steps":["trace[1528318461] 'process raft request' (duration: 705.217183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:58.32937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.959208773s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.212\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-10T18:47:58.329403Z","caller":"traceutil/trace.go:171","msg":"trace[1572538094] range","detail":"{range_begin:/registry/masterleases/162.253.55.212; range_end:; response_count:1; response_revision:1004; }","duration":"5.959315223s","start":"2026-02-10T18:47:52.370079Z","end":"2026-02-10T18:47:58.329394Z","steps":["trace[1572538094] 'agreement among raft nodes before linearized reading' (duration: 5.958904558s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:58.329429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:52.370055Z","time spent":"5.959369135s","remote":"127.0.0.1:45624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.212\" "} {"level":"warn","ts":"2026-02-10T18:47:58.329534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:57.621946Z","time spent":"707.429451ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:47:58.329842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.253835626s","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-02-10T18:47:58.329871Z","caller":"traceutil/trace.go:171","msg":"trace[1324429171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1004; }","duration":"6.253903356s","start":"2026-02-10T18:47:52.075961Z","end":"2026-02-10T18:47:58.329864Z","steps":["trace[1324429171] 'agreement among raft nodes before linearized reading' (duration: 6.253826825s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:58.329895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:52.075942Z","time spent":"6.253948927s","remote":"127.0.0.1:45338","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-10T18:47:59.667292Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.03121163s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-10T18:47:59.919208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.589151485s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-10T18:47:59.91934Z","caller":"traceutil/trace.go:171","msg":"trace[828808089] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1046; }","duration":"1.590733174s","start":"2026-02-10T18:47:58.328585Z","end":"2026-02-10T18:47:59.919318Z","steps":["trace[828808089] 'read index received' (duration: 1.417288ms)","trace[828808089] 'applied index is now lower than readState.Index' (duration: 1.589314216s)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:59.919392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.968752927s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:47:59.919455Z","caller":"traceutil/trace.go:171","msg":"trace[606901802] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1005; }","duration":"7.968844449s","start":"2026-02-10T18:47:51.950592Z","end":"2026-02-10T18:47:59.919437Z","steps":["trace[606901802] 'agreement among raft nodes before linearized reading' (duration: 6.379557733s)","trace[606901802] 'range keys from in-memory index tree' (duration: 1.589202835s)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:59.919504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:51.950577Z","time spent":"7.96891409s","remote":"127.0.0.1:45774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-02-10T18:47:59.922401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:58.331756Z","time spent":"1.590642674s","remote":"127.0.0.1:45624","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-10T18:47:59.924182Z","caller":"traceutil/trace.go:171","msg":"trace[1487128305] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"1.588973445s","start":"2026-02-10T18:47:58.335197Z","end":"2026-02-10T18:47:59.92417Z","steps":["trace[1487128305] 'process raft request' (duration: 1.588918464s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:59.925151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:58.33519Z","time spent":"1.589909047s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:47:59.92539Z","caller":"traceutil/trace.go:171","msg":"trace[2108585783] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"1.592075473s","start":"2026-02-10T18:47:58.333302Z","end":"2026-02-10T18:47:59.925377Z","steps":["trace[2108585783] 'process raft request' (duration: 1.589009204s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:59.925473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:58.33329Z","time spent":"1.592153484s","remote":"127.0.0.1:45680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T18:47:59.926514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.671034451s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-10T18:47:59.929111Z","caller":"traceutil/trace.go:171","msg":"trace[93972647] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1007; }","duration":"1.673672484s","start":"2026-02-10T18:47:58.255429Z","end":"2026-02-10T18:47:59.929101Z","steps":["trace[93972647] 'agreement among raft nodes before linearized reading' (duration: 1.67100534s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:59.929173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:58.255409Z","time spent":"1.673753176s","remote":"127.0.0.1:45338","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-10T18:47:59.92948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.800855738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:47:59.929561Z","caller":"traceutil/trace.go:171","msg":"trace[1446560398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1007; }","duration":"1.800933679s","start":"2026-02-10T18:47:58.128617Z","end":"2026-02-10T18:47:59.929551Z","steps":["trace[1446560398] 'agreement among raft nodes before linearized reading' (duration: 1.800842138s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:59.929646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:58.128555Z","time spent":"1.801082801s","remote":"127.0.0.1:45578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T18:47:59.929874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.085479982s","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-10T18:47:59.92998Z","caller":"traceutil/trace.go:171","msg":"trace[609477512] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1007; }","duration":"3.085621514s","start":"2026-02-10T18:47:56.844349Z","end":"2026-02-10T18:47:59.929971Z","steps":["trace[609477512] 'agreement among raft nodes before linearized reading' (duration: 3.085466152s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:59.930046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:56.844329Z","time spent":"3.085709045s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-10T18:47:59.930074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.404341772s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T18:47:59.930154Z","caller":"traceutil/trace.go:171","msg":"trace[2127014778] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1007; }","duration":"4.404475114s","start":"2026-02-10T18:47:55.525659Z","end":"2026-02-10T18:47:59.930134Z","steps":["trace[2127014778] 'agreement among raft nodes before linearized reading' (duration: 4.404317212s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:59.930258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:55.525641Z","time spent":"4.404557424s","remote":"127.0.0.1:45534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-02-10T18:47:59.93066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060890155s","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-10T18:47:59.931753Z","caller":"traceutil/trace.go:171","msg":"trace[1228708150] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1007; }","duration":"1.062016659s","start":"2026-02-10T18:47:58.869728Z","end":"2026-02-10T18:47:59.931745Z","steps":["trace[1228708150] 'agreement among raft nodes before linearized reading' (duration: 1.060886405s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:59.93185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:58.86971Z","time spent":"1.062131592s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T18:47:59.930774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.530675307s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:47:59.932054Z","caller":"traceutil/trace.go:171","msg":"trace[1047214534] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1007; }","duration":"1.531938893s","start":"2026-02-10T18:47:58.400089Z","end":"2026-02-10T18:47:59.932028Z","steps":["trace[1047214534] 'agreement among raft nodes before linearized reading' (duration: 1.530662307s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:59.932146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:58.400037Z","time spent":"1.532098055s","remote":"127.0.0.1:45296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-02-10T18:47:59.930944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.76409228s","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-02-10T18:47:59.932605Z","caller":"traceutil/trace.go:171","msg":"trace[1933664557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1007; }","duration":"4.765789391s","start":"2026-02-10T18:47:55.166807Z","end":"2026-02-10T18:47:59.932597Z","steps":["trace[1933664557] 'agreement among raft nodes before linearized reading' (duration: 4.764091739s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:59.932692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:55.166788Z","time spent":"4.765860202s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:48:00.507027Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10636548256744789225,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:48:00.785028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.35558ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:48:00.785756Z","caller":"traceutil/trace.go:171","msg":"trace[615378725] linearizableReadLoop","detail":"{readStateIndex:1057; appliedIndex:1051; }","duration":"779.744941ms","start":"2026-02-10T18:48:00.006Z","end":"2026-02-10T18:48:00.785745Z","steps":["trace[615378725] 'read index received' (duration: 522.626751ms)","trace[615378725] 'applied index is now lower than readState.Index' (duration: 257.11755ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:48:00.785853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.596613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:48:00.785878Z","caller":"traceutil/trace.go:171","msg":"trace[1698243601] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1012; }","duration":"854.621854ms","start":"2026-02-10T18:47:59.931248Z","end":"2026-02-10T18:48:00.78587Z","steps":["trace[1698243601] 'agreement among raft nodes before linearized reading' (duration: 854.537163ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:00.785939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:59.931231Z","time spent":"854.690984ms","remote":"127.0.0.1:45588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-10T18:48:00.786303Z","caller":"traceutil/trace.go:171","msg":"trace[1026245210] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"847.805576ms","start":"2026-02-10T18:47:59.938478Z","end":"2026-02-10T18:48:00.786284Z","steps":["trace[1026245210] 'process raft request' (duration: 847.159298ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:00.786439Z","caller":"traceutil/trace.go:171","msg":"trace[892352227] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"849.015061ms","start":"2026-02-10T18:47:59.936757Z","end":"2026-02-10T18:48:00.785772Z","steps":["trace[892352227] 'process raft request' (duration: 848.847499ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:00.786556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:59.936752Z","time spent":"849.777351ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:48:00.786734Z","caller":"traceutil/trace.go:171","msg":"trace[1225024407] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"850.075506ms","start":"2026-02-10T18:47:59.936647Z","end":"2026-02-10T18:48:00.786723Z","steps":["trace[1225024407] 'process raft request' (duration: 591.971103ms)","trace[1225024407] 'compare' (duration: 256.132697ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:48:00.786835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:59.936635Z","time spent":"850.176847ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:48:00.786994Z","caller":"traceutil/trace.go:171","msg":"trace[207676695] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"850.266369ms","start":"2026-02-10T18:47:59.936719Z","end":"2026-02-10T18:48:00.786986Z","steps":["trace[207676695] 'process raft request' (duration: 848.84357ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:00.787063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:59.936711Z","time spent":"850.330359ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:48:00.787351Z","caller":"traceutil/trace.go:171","msg":"trace[1354856965] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"777.121925ms","start":"2026-02-10T18:48:00.010222Z","end":"2026-02-10T18:48:00.787344Z","steps":["trace[1354856965] 'process raft request' (duration: 775.475973ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:00.787451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:48:00.010204Z","time spent":"777.200877ms","remote":"127.0.0.1:45680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:48:00.787638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:48:00.008648Z","time spent":"778.98823ms","remote":"127.0.0.1:45624","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-10T18:48:00.790259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:59.93847Z","time spent":"847.872437ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:48:02.904678Z","caller":"traceutil/trace.go:171","msg":"trace[204703978] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"103.72583ms","start":"2026-02-10T18:48:02.800929Z","end":"2026-02-10T18:48:02.904655Z","steps":["trace[204703978] 'process raft request' (duration: 103.68188ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:02.905095Z","caller":"traceutil/trace.go:171","msg":"trace[434990168] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"105.937902ms","start":"2026-02-10T18:48:02.799112Z","end":"2026-02-10T18:48:02.90505Z","steps":["trace[434990168] 'process raft request' (duration: 103.991244ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:02.90523Z","caller":"traceutil/trace.go:171","msg":"trace[1741432709] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"105.72578ms","start":"2026-02-10T18:48:02.799494Z","end":"2026-02-10T18:48:02.90522Z","steps":["trace[1741432709] 'process raft request' (duration: 105.05086ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:04.218824Z","caller":"traceutil/trace.go:171","msg":"trace[1411346460] linearizableReadLoop","detail":"{readStateIndex:1070; appliedIndex:1069; }","duration":"137.494659ms","start":"2026-02-10T18:48:04.081317Z","end":"2026-02-10T18:48:04.218811Z","steps":["trace[1411346460] 'read index received' (duration: 137.356787ms)","trace[1411346460] 'applied index is now lower than readState.Index' (duration: 137.402µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:48:04.219076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.741263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:5 size:1780"} {"level":"info","ts":"2026-02-10T18:48:04.219122Z","caller":"traceutil/trace.go:171","msg":"trace[333675398] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:5; response_revision:1024; }","duration":"137.836784ms","start":"2026-02-10T18:48:04.081279Z","end":"2026-02-10T18:48:04.219116Z","steps":["trace[333675398] 'agreement among raft nodes before linearized reading' (duration: 137.685511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:04.219181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.616104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:48:04.219273Z","caller":"traceutil/trace.go:171","msg":"trace[489745049] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"271.878444ms","start":"2026-02-10T18:48:03.947389Z","end":"2026-02-10T18:48:04.219267Z","steps":["trace[489745049] 'process raft request' (duration: 271.332926ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:04.219281Z","caller":"traceutil/trace.go:171","msg":"trace[772592580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1024; }","duration":"105.677295ms","start":"2026-02-10T18:48:04.113536Z","end":"2026-02-10T18:48:04.219213Z","steps":["trace[772592580] 'agreement among raft nodes before linearized reading' (duration: 105.629604ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:05.152624Z","caller":"traceutil/trace.go:171","msg":"trace[1931301566] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1070; }","duration":"290.819123ms","start":"2026-02-10T18:48:04.861783Z","end":"2026-02-10T18:48:05.152602Z","steps":["trace[1931301566] 'read index received' (duration: 290.641981ms)","trace[1931301566] 'applied index is now lower than readState.Index' (duration: 176.162µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:48:05.15299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.738513ms","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-10T18:48:05.153052Z","caller":"traceutil/trace.go:171","msg":"trace[1453413650] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"330.73478ms","start":"2026-02-10T18:48:04.822304Z","end":"2026-02-10T18:48:05.153039Z","steps":["trace[1453413650] 'process raft request' (duration: 330.146781ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:05.153094Z","caller":"traceutil/trace.go:171","msg":"trace[1836382923] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1025; }","duration":"242.862455ms","start":"2026-02-10T18:48:04.910192Z","end":"2026-02-10T18:48:05.153055Z","steps":["trace[1836382923] 'agreement among raft nodes before linearized reading' (duration: 242.672662ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:05.153181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:48:04.822294Z","time spent":"330.820301ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T18:48:05.153359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.575986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"warn","ts":"2026-02-10T18:48:05.153368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.662779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T18:48:05.153393Z","caller":"traceutil/trace.go:171","msg":"trace[937246990] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1025; }","duration":"291.627157ms","start":"2026-02-10T18:48:04.861755Z","end":"2026-02-10T18:48:05.153382Z","steps":["trace[937246990] 'agreement among raft nodes before linearized reading' (duration: 291.491215ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:05.153418Z","caller":"traceutil/trace.go:171","msg":"trace[1857860815] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1025; }","duration":"174.74309ms","start":"2026-02-10T18:48:04.978647Z","end":"2026-02-10T18:48:05.15339Z","steps":["trace[1857860815] 'agreement among raft nodes before linearized reading' (duration: 174.650938ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:05.153739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.86049ms","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-02-10T18:48:05.153774Z","caller":"traceutil/trace.go:171","msg":"trace[78826610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1025; }","duration":"241.912121ms","start":"2026-02-10T18:48:04.911852Z","end":"2026-02-10T18:48:05.153764Z","steps":["trace[78826610] 'agreement among raft nodes before linearized reading' (duration: 241.823609ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:05.154003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.407033ms","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-10T18:48:05.154036Z","caller":"traceutil/trace.go:171","msg":"trace[1908190656] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1025; }","duration":"243.453955ms","start":"2026-02-10T18:48:04.910569Z","end":"2026-02-10T18:48:05.154023Z","steps":["trace[1908190656] 'agreement among raft nodes before linearized reading' (duration: 243.353923ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:05.572412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.456921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:48:05.572996Z","caller":"traceutil/trace.go:171","msg":"trace[2074390382] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"407.373569ms","start":"2026-02-10T18:48:05.165131Z","end":"2026-02-10T18:48:05.572504Z","steps":["trace[2074390382] 'process raft request' (duration: 242.740025ms)","trace[2074390382] 'compare' (duration: 164.272488ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:48:05.573162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:48:05.165114Z","time spent":"407.937718ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:48:05.602732Z","caller":"traceutil/trace.go:171","msg":"trace[1018425643] linearizableReadLoop","detail":"{readStateIndex:1074; appliedIndex:1071; }","duration":"384.785666ms","start":"2026-02-10T18:48:05.217929Z","end":"2026-02-10T18:48:05.602715Z","steps":["trace[1018425643] 'read index received' (duration: 189.95267ms)","trace[1018425643] 'applied index is now lower than readState.Index' (duration: 194.831936ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:48:05.602985Z","caller":"traceutil/trace.go:171","msg":"trace[529606302] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"437.408469ms","start":"2026-02-10T18:48:05.165324Z","end":"2026-02-10T18:48:05.602732Z","steps":["trace[529606302] 'process raft request' (duration: 437.209946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:05.603125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.184882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-10T18:48:05.603206Z","caller":"traceutil/trace.go:171","msg":"trace[1172931255] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1028; }","duration":"385.304024ms","start":"2026-02-10T18:48:05.21789Z","end":"2026-02-10T18:48:05.603194Z","steps":["trace[1172931255] 'agreement among raft nodes before linearized reading' (duration: 384.887438ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:05.603356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:48:05.217874Z","time spent":"385.465096ms","remote":"127.0.0.1:45688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":12751,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-10T18:48:05.603492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:48:05.165317Z","time spent":"437.831345ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:48:05.603716Z","caller":"traceutil/trace.go:171","msg":"trace[1036863089] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"438.331183ms","start":"2026-02-10T18:48:05.165371Z","end":"2026-02-10T18:48:05.603702Z","steps":["trace[1036863089] 'process raft request' (duration: 437.303667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:05.603841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:48:05.165366Z","time spent":"438.386324ms","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:48:06.464913Z","caller":"traceutil/trace.go:171","msg":"trace[105805914] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"238.320511ms","start":"2026-02-10T18:48:06.226567Z","end":"2026-02-10T18:48:06.464888Z","steps":["trace[105805914] 'process raft request' (duration: 238.148798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:10.7279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.077549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:daemon-set-controller\" ","response":"range_response_count:1 size:958"} {"level":"info","ts":"2026-02-10T18:48:10.727978Z","caller":"traceutil/trace.go:171","msg":"trace[1061582794] range","detail":"{range_begin:/registry/clusterroles/system:controller:daemon-set-controller; range_end:; response_count:1; response_revision:1041; }","duration":"117.187491ms","start":"2026-02-10T18:48:10.610772Z","end":"2026-02-10T18:48:10.72796Z","steps":["trace[1061582794] 'range keys from in-memory index tree' (duration: 117.010818ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:17.417101Z","caller":"traceutil/trace.go:171","msg":"trace[2074988844] linearizableReadLoop","detail":"{readStateIndex:1107; appliedIndex:1106; }","duration":"119.461534ms","start":"2026-02-10T18:48:17.297583Z","end":"2026-02-10T18:48:17.417044Z","steps":["trace[2074988844] 'read index received' (duration: 119.223139ms)","trace[2074988844] 'applied index is now lower than readState.Index' (duration: 237.485µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:48:17.417244Z","caller":"traceutil/trace.go:171","msg":"trace[1508970298] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"150.54455ms","start":"2026-02-10T18:48:17.26669Z","end":"2026-02-10T18:48:17.417234Z","steps":["trace[1508970298] 'process raft request' (duration: 150.174742ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:17.417557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.959664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node-proxier\" ","response":"range_response_count:1 size:712"} {"level":"info","ts":"2026-02-10T18:48:17.417632Z","caller":"traceutil/trace.go:171","msg":"trace[1670974702] range","detail":"{range_begin:/registry/clusterroles/system:node-proxier; range_end:; response_count:1; response_revision:1058; }","duration":"120.069707ms","start":"2026-02-10T18:48:17.297551Z","end":"2026-02-10T18:48:17.41762Z","steps":["trace[1670974702] 'agreement among raft nodes before linearized reading' (duration: 119.919164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:17.417959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.84301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:persistent-volume-provisioner\" ","response":"range_response_count:1 size:812"} {"level":"info","ts":"2026-02-10T18:48:17.419001Z","caller":"traceutil/trace.go:171","msg":"trace[1994192814] range","detail":"{range_begin:/registry/clusterroles/system:persistent-volume-provisioner; range_end:; response_count:1; response_revision:1058; }","duration":"115.906252ms","start":"2026-02-10T18:48:17.30308Z","end":"2026-02-10T18:48:17.418986Z","steps":["trace[1994192814] 'agreement among raft nodes before linearized reading' (duration: 114.786199ms)"],"step_count":1}