{"level":"warn","ts":"2026-02-05T17:39:57.254449Z","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-05T17:39:57.254985Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-05T17:39:57.255082Z","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-05T17:39:57.255096Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-02-05T17:39:57.255115Z","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-05T17:39:57.255893Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-02-05T17:39:57.256012Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-05T17:39:57.265019Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.486567ms"} {"level":"info","ts":"2026-02-05T17:39:57.282266Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-02-05T17:39:57.282523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-02-05T17:39:57.282615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-02-05T17:39:57.282685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-05T17:39:57.282694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-02-05T17:39:57.2828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-02-05T17:39:57.302692Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-05T17:39:57.318955Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-05T17:39:57.328942Z","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-05T17:39:57.342919Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-05T17:39:57.343703Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-05T17:39:57.343912Z","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-05T17:39:57.343956Z","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-05T17:39:57.344016Z","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-05T17:39:57.344294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-02-05T17:39:57.344454Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-02-05T17:39:57.353705Z","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-05T17:39:57.35865Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-02-05T17:39:57.358668Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-02-05T17:39:57.359696Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-05T17:39:57.359721Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-05T17:39:57.586594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-02-05T17:39:57.586647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-05T17:39:57.586662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-02-05T17:39:57.586807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-02-05T17:39:57.586874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-02-05T17:39:57.586926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-02-05T17:39:57.586955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-02-05T17:39:57.59073Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-02-05T17:39:57.590753Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-05T17:39:57.591101Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T17:39:57.592063Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-05T17:39:57.593345Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-05T17:39:57.593671Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T17:39:57.605531Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T17:39:57.605554Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T17:39:57.59498Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-02-05T17:39:57.595368Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-05T17:39:57.605701Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-02-05T17:40:06.390709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.131394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:06.390832Z","caller":"traceutil/trace.go:171","msg":"trace[387896564] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:0; response_revision:287; }","duration":"107.517837ms","start":"2026-02-05T17:40:06.283289Z","end":"2026-02-05T17:40:06.390807Z","steps":["trace[387896564] 'range keys from in-memory index tree' (duration: 107.061502ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:06.832413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.089887ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:40:06.83255Z","caller":"traceutil/trace.go:171","msg":"trace[1334505671] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"149.621212ms","start":"2026-02-05T17:40:06.682909Z","end":"2026-02-05T17:40:06.83253Z","steps":["trace[1334505671] 'compare' (duration: 146.924252ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:07.820106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.688411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-05T17:40:07.820172Z","caller":"traceutil/trace.go:171","msg":"trace[1001003670] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:295; }","duration":"187.814566ms","start":"2026-02-05T17:40:07.632341Z","end":"2026-02-05T17:40:07.820155Z","steps":["trace[1001003670] 'range keys from in-memory index tree' (duration: 187.589768ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:08.068661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.251965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-02-05T17:40:08.069269Z","caller":"traceutil/trace.go:171","msg":"trace[126442433] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:307; }","duration":"117.085216ms","start":"2026-02-05T17:40:07.95038Z","end":"2026-02-05T17:40:08.067466Z","steps":["trace[126442433] 'read index received' (duration: 96.161478ms)","trace[126442433] 'applied index is now lower than readState.Index' (duration: 20.922498ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:08.069514Z","caller":"traceutil/trace.go:171","msg":"trace[1825463688] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"119.715164ms","start":"2026-02-05T17:40:07.948164Z","end":"2026-02-05T17:40:08.067879Z","steps":["trace[1825463688] 'process raft request' (duration: 98.363552ms)","trace[1825463688] 'compare' (duration: 20.804174ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:08.069605Z","caller":"traceutil/trace.go:171","msg":"trace[507985142] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:298; }","duration":"118.352429ms","start":"2026-02-05T17:40:07.95036Z","end":"2026-02-05T17:40:08.068712Z","steps":["trace[507985142] 'agreement among raft nodes before linearized reading' (duration: 118.187023ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:08.093037Z","caller":"traceutil/trace.go:171","msg":"trace[1750353046] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"140.752456ms","start":"2026-02-05T17:40:07.952268Z","end":"2026-02-05T17:40:08.09302Z","steps":["trace[1750353046] 'process raft request' (duration: 140.586661ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:08.642633Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148893456196807,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-05T17:40:08.742935Z","caller":"traceutil/trace.go:171","msg":"trace[1092004818] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"643.695137ms","start":"2026-02-05T17:40:08.099222Z","end":"2026-02-05T17:40:08.742917Z","steps":["trace[1092004818] 'process raft request' (duration: 643.573713ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:08.743178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:08.099193Z","time spent":"643.79267ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:40:08.789285Z","caller":"traceutil/trace.go:171","msg":"trace[11072106] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:309; }","duration":"646.932265ms","start":"2026-02-05T17:40:08.142334Z","end":"2026-02-05T17:40:08.789267Z","steps":["trace[11072106] 'read index received' (duration: 600.567217ms)","trace[11072106] 'applied index is now lower than readState.Index' (duration: 46.364117ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:08.789452Z","caller":"traceutil/trace.go:171","msg":"trace[1503356399] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"687.771837ms","start":"2026-02-05T17:40:08.10167Z","end":"2026-02-05T17:40:08.789442Z","steps":["trace[1503356399] 'process raft request' (duration: 687.520819ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:08.789517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:08.101663Z","time spent":"687.815859ms","remote":"127.0.0.1:58664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-05T17:40:08.789714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.38465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-05T17:40:08.789748Z","caller":"traceutil/trace.go:171","msg":"trace[837575828] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:301; }","duration":"647.519924ms","start":"2026-02-05T17:40:08.142217Z","end":"2026-02-05T17:40:08.789737Z","steps":["trace[837575828] 'agreement among raft nodes before linearized reading' (duration: 647.437841ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:08.789776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:08.142168Z","time spent":"647.601507ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-05T17:40:09.058816Z","caller":"traceutil/trace.go:171","msg":"trace[251452144] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:315; }","duration":"108.275372ms","start":"2026-02-05T17:40:08.950521Z","end":"2026-02-05T17:40:09.058796Z","steps":["trace[251452144] 'read index received' (duration: 95.094123ms)","trace[251452144] 'applied index is now lower than readState.Index' (duration: 13.180559ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:09.059156Z","caller":"traceutil/trace.go:171","msg":"trace[1966928488] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"109.878896ms","start":"2026-02-05T17:40:08.949271Z","end":"2026-02-05T17:40:09.05915Z","steps":["trace[1966928488] 'process raft request' (duration: 109.427881ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:09.059588Z","caller":"traceutil/trace.go:171","msg":"trace[1444538492] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"109.453462ms","start":"2026-02-05T17:40:08.950129Z","end":"2026-02-05T17:40:09.059582Z","steps":["trace[1444538492] 'process raft request' (duration: 108.648965ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:09.060031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.072169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-05T17:40:09.06105Z","caller":"traceutil/trace.go:171","msg":"trace[356582642] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:307; }","duration":"110.111723ms","start":"2026-02-05T17:40:08.950931Z","end":"2026-02-05T17:40:09.061042Z","steps":["trace[356582642] 'agreement among raft nodes before linearized reading' (duration: 109.069459ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:09.060105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.580686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-02-05T17:40:09.060754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.722208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-05T17:40:09.061687Z","caller":"traceutil/trace.go:171","msg":"trace[1022562520] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:307; }","duration":"109.664449ms","start":"2026-02-05T17:40:08.952014Z","end":"2026-02-05T17:40:09.061678Z","steps":["trace[1022562520] 'agreement among raft nodes before linearized reading' (duration: 108.725787ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:09.061846Z","caller":"traceutil/trace.go:171","msg":"trace[1345312215] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:307; }","duration":"111.321264ms","start":"2026-02-05T17:40:08.950519Z","end":"2026-02-05T17:40:09.06184Z","steps":["trace[1345312215] 'agreement among raft nodes before linearized reading' (duration: 109.169442ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:14.579067Z","caller":"traceutil/trace.go:171","msg":"trace[487293283] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:384; }","duration":"464.5375ms","start":"2026-02-05T17:40:14.114508Z","end":"2026-02-05T17:40:14.579045Z","steps":["trace[487293283] 'read index received' (duration: 464.352884ms)","trace[487293283] 'applied index is now lower than readState.Index' (duration: 183.696µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:40:14.579202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.669734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-05T17:40:14.579233Z","caller":"traceutil/trace.go:171","msg":"trace[1462232562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:373; }","duration":"464.735367ms","start":"2026-02-05T17:40:14.114488Z","end":"2026-02-05T17:40:14.579224Z","steps":["trace[1462232562] 'agreement among raft nodes before linearized reading' (duration: 464.645414ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:14.579264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:14.114481Z","time spent":"464.776178ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-05T17:40:14.579556Z","caller":"traceutil/trace.go:171","msg":"trace[1287839368] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"480.008207ms","start":"2026-02-05T17:40:14.099538Z","end":"2026-02-05T17:40:14.579546Z","steps":["trace[1287839368] 'process raft request' (duration: 479.391846ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:14.579628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:14.09952Z","time spent":"480.061448ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:15.646967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.979182ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:40:15.647062Z","caller":"traceutil/trace.go:171","msg":"trace[1591785154] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:385; }","duration":"883.937582ms","start":"2026-02-05T17:40:14.763108Z","end":"2026-02-05T17:40:15.647046Z","steps":["trace[1591785154] 'read index received' (duration: 395.698781ms)","trace[1591785154] 'applied index is now lower than readState.Index' (duration: 488.237701ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:15.647146Z","caller":"traceutil/trace.go:171","msg":"trace[1356774479] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"1.05261188s","start":"2026-02-05T17:40:14.594523Z","end":"2026-02-05T17:40:15.647135Z","steps":["trace[1356774479] 'process raft request' (duration: 564.39328ms)","trace[1356774479] 'compare' (duration: 487.196436ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:40:15.647201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:14.59451Z","time spent":"1.052661791s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:15.647337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.239512ms","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-05T17:40:15.647364Z","caller":"traceutil/trace.go:171","msg":"trace[795884402] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:374; }","duration":"884.301014ms","start":"2026-02-05T17:40:14.763054Z","end":"2026-02-05T17:40:15.647355Z","steps":["trace[795884402] 'agreement among raft nodes before linearized reading' (duration: 884.243602ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:15.647393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:14.763032Z","time spent":"884.354215ms","remote":"127.0.0.1:58730","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-05T17:40:15.647476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.816507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:15.647499Z","caller":"traceutil/trace.go:171","msg":"trace[58334059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:374; }","duration":"856.837998ms","start":"2026-02-05T17:40:14.790653Z","end":"2026-02-05T17:40:15.647491Z","steps":["trace[58334059] 'agreement among raft nodes before linearized reading' (duration: 856.805047ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:15.647527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:14.790607Z","time spent":"856.91049ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T17:40:15.647706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.484582ms","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-05T17:40:15.647734Z","caller":"traceutil/trace.go:171","msg":"trace[2006350387] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:374; }","duration":"810.545534ms","start":"2026-02-05T17:40:14.83718Z","end":"2026-02-05T17:40:15.647725Z","steps":["trace[2006350387] 'agreement among raft nodes before linearized reading' (duration: 810.493372ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:15.647761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:14.83716Z","time spent":"810.595245ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-05T17:40:15.776571Z","caller":"traceutil/trace.go:171","msg":"trace[798628272] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"122.008181ms","start":"2026-02-05T17:40:15.654538Z","end":"2026-02-05T17:40:15.776547Z","steps":["trace[798628272] 'process raft request' (duration: 121.840505ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:15.776999Z","caller":"traceutil/trace.go:171","msg":"trace[145684199] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:387; }","duration":"121.841135ms","start":"2026-02-05T17:40:15.655134Z","end":"2026-02-05T17:40:15.776975Z","steps":["trace[145684199] 'read index received' (duration: 121.832965ms)","trace[145684199] 'applied index is now lower than readState.Index' (duration: 7.04µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:40:15.777124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.958969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:15.777147Z","caller":"traceutil/trace.go:171","msg":"trace[444529120] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:375; }","duration":"122.028572ms","start":"2026-02-05T17:40:15.65511Z","end":"2026-02-05T17:40:15.777139Z","steps":["trace[444529120] 'agreement among raft nodes before linearized reading' (duration: 121.944529ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:15.777195Z","caller":"traceutil/trace.go:171","msg":"trace[1940815777] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"121.1031ms","start":"2026-02-05T17:40:15.65608Z","end":"2026-02-05T17:40:15.777183Z","steps":["trace[1940815777] 'process raft request' (duration: 121.038458ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:16.727217Z","caller":"traceutil/trace.go:171","msg":"trace[1977570023] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:389; }","duration":"132.561983ms","start":"2026-02-05T17:40:16.594582Z","end":"2026-02-05T17:40:16.727144Z","steps":["trace[1977570023] 'read index received' (duration: 132.363146ms)","trace[1977570023] 'applied index is now lower than readState.Index' (duration: 197.637µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:40:16.727365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.755409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-05T17:40:16.727399Z","caller":"traceutil/trace.go:171","msg":"trace[1061007668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:377; }","duration":"132.861303ms","start":"2026-02-05T17:40:16.594527Z","end":"2026-02-05T17:40:16.727389Z","steps":["trace[1061007668] 'agreement among raft nodes before linearized reading' (duration: 132.755949ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:16.727703Z","caller":"traceutil/trace.go:171","msg":"trace[1541909268] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"204.776552ms","start":"2026-02-05T17:40:16.522915Z","end":"2026-02-05T17:40:16.727692Z","steps":["trace[1541909268] 'process raft request' (duration: 204.064488ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:31.037846Z","caller":"traceutil/trace.go:171","msg":"trace[1307712940] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"109.759222ms","start":"2026-02-05T17:40:30.928059Z","end":"2026-02-05T17:40:31.037818Z","steps":["trace[1307712940] 'process raft request' (duration: 32.893357ms)","trace[1307712940] 'compare' (duration: 76.743121ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:31.038642Z","caller":"traceutil/trace.go:171","msg":"trace[1861719000] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"101.211057ms","start":"2026-02-05T17:40:30.937416Z","end":"2026-02-05T17:40:31.038627Z","steps":["trace[1861719000] 'process raft request' (duration: 100.99312ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:31.038627Z","caller":"traceutil/trace.go:171","msg":"trace[1306545300] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"107.544489ms","start":"2026-02-05T17:40:30.931064Z","end":"2026-02-05T17:40:31.038608Z","steps":["trace[1306545300] 'process raft request' (duration: 107.216878ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:31.042943Z","caller":"traceutil/trace.go:171","msg":"trace[370556346] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"110.60262ms","start":"2026-02-05T17:40:30.93233Z","end":"2026-02-05T17:40:31.042933Z","steps":["trace[370556346] 'process raft request' (duration: 106.052088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:34.4189Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148893456197166,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-05T17:40:34.423854Z","caller":"traceutil/trace.go:171","msg":"trace[1068150600] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"637.465879ms","start":"2026-02-05T17:40:33.786363Z","end":"2026-02-05T17:40:34.423829Z","steps":["trace[1068150600] 'process raft request' (duration: 637.305934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:34.423985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:33.786355Z","time spent":"637.539692ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:40:34.426253Z","caller":"traceutil/trace.go:171","msg":"trace[2013273224] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:500; }","duration":"508.087132ms","start":"2026-02-05T17:40:33.918142Z","end":"2026-02-05T17:40:34.426229Z","steps":["trace[2013273224] 'read index received' (duration: 505.590269ms)","trace[2013273224] 'applied index is now lower than readState.Index' (duration: 2.496103ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:34.426422Z","caller":"traceutil/trace.go:171","msg":"trace[1919469475] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"516.884006ms","start":"2026-02-05T17:40:33.909531Z","end":"2026-02-05T17:40:34.426415Z","steps":["trace[1919469475] 'process raft request' (duration: 516.641338ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:34.426465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:33.909513Z","time spent":"516.925987ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:34.426744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.597959ms","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-05T17:40:34.426773Z","caller":"traceutil/trace.go:171","msg":"trace[179663102] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:484; }","duration":"508.636861ms","start":"2026-02-05T17:40:33.918124Z","end":"2026-02-05T17:40:34.426761Z","steps":["trace[179663102] 'agreement among raft nodes before linearized reading' (duration: 508.489316ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:34.426793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:33.918117Z","time spent":"508.672032ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-05T17:40:34.426924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.011256ms","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-05T17:40:34.426943Z","caller":"traceutil/trace.go:171","msg":"trace[1323876369] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:484; }","duration":"495.030367ms","start":"2026-02-05T17:40:33.931906Z","end":"2026-02-05T17:40:34.426936Z","steps":["trace[1323876369] 'agreement among raft nodes before linearized reading' (duration: 494.970385ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:34.42696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:33.931886Z","time spent":"495.069958ms","remote":"127.0.0.1:58730","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-05T17:40:37.045581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.982236ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-05T17:40:37.045699Z","caller":"traceutil/trace.go:171","msg":"trace[1770199424] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:505; }","duration":"618.012411ms","start":"2026-02-05T17:40:36.427667Z","end":"2026-02-05T17:40:37.04568Z","steps":["trace[1770199424] 'read index received' (duration: 21.913921ms)","trace[1770199424] 'applied index is now lower than readState.Index' (duration: 596.09725ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:40:37.046101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.422075ms","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-05T17:40:37.046122Z","caller":"traceutil/trace.go:171","msg":"trace[1012555475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:487; }","duration":"618.478957ms","start":"2026-02-05T17:40:36.427633Z","end":"2026-02-05T17:40:37.046112Z","steps":["trace[1012555475] 'agreement among raft nodes before linearized reading' (duration: 618.325462ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:37.046144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:36.427602Z","time spent":"618.536829ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-05T17:40:37.046213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.067253ms","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-05T17:40:37.046285Z","caller":"traceutil/trace.go:171","msg":"trace[1548440020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:487; }","duration":"609.180237ms","start":"2026-02-05T17:40:36.437085Z","end":"2026-02-05T17:40:37.046265Z","steps":["trace[1548440020] 'agreement among raft nodes before linearized reading' (duration: 608.955859ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:37.046326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:36.437047Z","time spent":"609.27081ms","remote":"127.0.0.1:58730","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-05T17:40:37.046378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.394871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:37.046398Z","caller":"traceutil/trace.go:171","msg":"trace[98512850] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:487; }","duration":"228.412852ms","start":"2026-02-05T17:40:36.817978Z","end":"2026-02-05T17:40:37.046391Z","steps":["trace[98512850] 'agreement among raft nodes before linearized reading' (duration: 228.377731ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:37.046544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.920904ms","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-05T17:40:37.04656Z","caller":"traceutil/trace.go:171","msg":"trace[658186644] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:487; }","duration":"598.962205ms","start":"2026-02-05T17:40:36.447594Z","end":"2026-02-05T17:40:37.046556Z","steps":["trace[658186644] 'agreement among raft nodes before linearized reading' (duration: 598.916934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:37.046573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:36.447578Z","time spent":"598.991747ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-05T17:40:37.454382Z","caller":"traceutil/trace.go:171","msg":"trace[1519521282] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"399.047865ms","start":"2026-02-05T17:40:37.055316Z","end":"2026-02-05T17:40:37.454363Z","steps":["trace[1519521282] 'process raft request' (duration: 398.8785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:37.454513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:37.05529Z","time spent":"399.163119ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:40:37.487117Z","caller":"traceutil/trace.go:171","msg":"trace[1887887728] linearizableReadLoop","detail":"{readStateIndex:509; appliedIndex:507; }","duration":"383.31619ms","start":"2026-02-05T17:40:37.103772Z","end":"2026-02-05T17:40:37.487088Z","steps":["trace[1887887728] 'read index received' (duration: 351.036163ms)","trace[1887887728] 'applied index is now lower than readState.Index' (duration: 32.279197ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:37.487167Z","caller":"traceutil/trace.go:171","msg":"trace[997148496] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"431.546649ms","start":"2026-02-05T17:40:37.05557Z","end":"2026-02-05T17:40:37.487117Z","steps":["trace[997148496] 'process raft request' (duration: 431.27648ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:37.487334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:37.055548Z","time spent":"431.702655ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:37.48735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.544228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-05T17:40:37.487392Z","caller":"traceutil/trace.go:171","msg":"trace[1399073593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:490; }","duration":"383.635381ms","start":"2026-02-05T17:40:37.103735Z","end":"2026-02-05T17:40:37.48737Z","steps":["trace[1399073593] 'agreement among raft nodes before linearized reading' (duration: 383.457305ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:37.487423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:37.103718Z","time spent":"383.699423ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-05T17:40:37.487558Z","caller":"traceutil/trace.go:171","msg":"trace[1433604435] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"431.158807ms","start":"2026-02-05T17:40:37.056393Z","end":"2026-02-05T17:40:37.487552Z","steps":["trace[1433604435] 'process raft request' (duration: 430.65804ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:37.487638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:37.056384Z","time spent":"431.188317ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:42.835571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.224525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rf9f9\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-05T17:40:42.835634Z","caller":"traceutil/trace.go:171","msg":"trace[875509444] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rf9f9; range_end:; response_count:1; response_revision:504; }","duration":"525.326709ms","start":"2026-02-05T17:40:42.310291Z","end":"2026-02-05T17:40:42.835618Z","steps":["trace[875509444] 'range keys from in-memory index tree' (duration: 525.102481ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:42.835667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:42.310277Z","time spent":"525.38208ms","remote":"127.0.0.1:58646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16675,"request content":"key:\"/registry/pods/kube-system/cilium-rf9f9\" "} {"level":"info","ts":"2026-02-05T17:40:43.813948Z","caller":"traceutil/trace.go:171","msg":"trace[1551641390] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:524; }","duration":"324.209176ms","start":"2026-02-05T17:40:43.489724Z","end":"2026-02-05T17:40:43.813934Z","steps":["trace[1551641390] 'read index received' (duration: 324.095632ms)","trace[1551641390] 'applied index is now lower than readState.Index' (duration: 112.824µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:43.814344Z","caller":"traceutil/trace.go:171","msg":"trace[720725178] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"964.676826ms","start":"2026-02-05T17:40:42.84966Z","end":"2026-02-05T17:40:43.814336Z","steps":["trace[720725178] 'process raft request' (duration: 964.17575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:43.814413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:42.849647Z","time spent":"964.717297ms","remote":"127.0.0.1:58646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:43.81456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.833688ms","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-05T17:40:43.814602Z","caller":"traceutil/trace.go:171","msg":"trace[1327568750] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:505; }","duration":"324.899559ms","start":"2026-02-05T17:40:43.489696Z","end":"2026-02-05T17:40:43.814595Z","steps":["trace[1327568750] 'agreement among raft nodes before linearized reading' (duration: 324.805196ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:43.81462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:43.489682Z","time spent":"324.933131ms","remote":"127.0.0.1:58730","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-05T17:40:43.814795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.441024ms","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-05T17:40:43.814863Z","caller":"traceutil/trace.go:171","msg":"trace[641878491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:505; }","duration":"270.539347ms","start":"2026-02-05T17:40:43.544307Z","end":"2026-02-05T17:40:43.814846Z","steps":["trace[641878491] 'agreement among raft nodes before linearized reading' (duration: 270.33062ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:43.814906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.906624ms","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-05T17:40:43.814931Z","caller":"traceutil/trace.go:171","msg":"trace[603128607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:505; }","duration":"239.940486ms","start":"2026-02-05T17:40:43.574981Z","end":"2026-02-05T17:40:43.814922Z","steps":["trace[603128607] 'agreement among raft nodes before linearized reading' (duration: 239.883564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:43.815041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.502812ms","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-05T17:40:43.815069Z","caller":"traceutil/trace.go:171","msg":"trace[106667478] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:505; }","duration":"248.559264ms","start":"2026-02-05T17:40:43.566501Z","end":"2026-02-05T17:40:43.81506Z","steps":["trace[106667478] 'agreement among raft nodes before linearized reading' (duration: 248.472751ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:43.998836Z","caller":"traceutil/trace.go:171","msg":"trace[1520271245] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:525; }","duration":"160.192674ms","start":"2026-02-05T17:40:43.838622Z","end":"2026-02-05T17:40:43.998815Z","steps":["trace[1520271245] 'read index received' (duration: 93.995746ms)","trace[1520271245] 'applied index is now lower than readState.Index' (duration: 66.196138ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:40:43.999044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.407342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rf9f9\" ","response":"range_response_count:1 size:16814"} {"level":"info","ts":"2026-02-05T17:40:43.999082Z","caller":"traceutil/trace.go:171","msg":"trace[164855692] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rf9f9; range_end:; response_count:1; response_revision:509; }","duration":"160.487165ms","start":"2026-02-05T17:40:43.838586Z","end":"2026-02-05T17:40:43.999073Z","steps":["trace[164855692] 'agreement among raft nodes before linearized reading' (duration: 160.309209ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:43.999371Z","caller":"traceutil/trace.go:171","msg":"trace[227520252] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"174.979968ms","start":"2026-02-05T17:40:43.824379Z","end":"2026-02-05T17:40:43.999359Z","steps":["trace[227520252] 'process raft request' (duration: 108.148758ms)","trace[227520252] 'compare' (duration: 65.769944ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:43.999487Z","caller":"traceutil/trace.go:171","msg":"trace[1323407321] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"174.961038ms","start":"2026-02-05T17:40:43.824517Z","end":"2026-02-05T17:40:43.999478Z","steps":["trace[1323407321] 'process raft request' (duration: 174.177021ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:43.999607Z","caller":"traceutil/trace.go:171","msg":"trace[1930422377] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"169.128163ms","start":"2026-02-05T17:40:43.830472Z","end":"2026-02-05T17:40:43.9996Z","steps":["trace[1930422377] 'process raft request' (duration: 168.266134ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:43.999699Z","caller":"traceutil/trace.go:171","msg":"trace[1961981689] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"169.167075ms","start":"2026-02-05T17:40:43.830525Z","end":"2026-02-05T17:40:43.999692Z","steps":["trace[1961981689] 'process raft request' (duration: 168.242244ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:46.789967Z","caller":"traceutil/trace.go:171","msg":"trace[1719784293] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"369.479718ms","start":"2026-02-05T17:40:46.420456Z","end":"2026-02-05T17:40:46.789936Z","steps":["trace[1719784293] 'process raft request' (duration: 369.373564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.790082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.42044Z","time spent":"369.576691ms","remote":"127.0.0.1:58530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T17:40:46.790424Z","caller":"traceutil/trace.go:171","msg":"trace[1929585642] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:550; }","duration":"368.806226ms","start":"2026-02-05T17:40:46.421609Z","end":"2026-02-05T17:40:46.790416Z","steps":["trace[1929585642] 'read index received' (duration: 368.803126ms)","trace[1929585642] 'applied index is now lower than readState.Index' (duration: 2.62µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:40:46.790609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.004462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:46.790637Z","caller":"traceutil/trace.go:171","msg":"trace[1040715901] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:530; }","duration":"369.050384ms","start":"2026-02-05T17:40:46.421579Z","end":"2026-02-05T17:40:46.790629Z","steps":["trace[1040715901] 'agreement among raft nodes before linearized reading' (duration: 368.94064ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.790672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.421569Z","time spent":"369.083965ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"info","ts":"2026-02-05T17:40:46.873318Z","caller":"traceutil/trace.go:171","msg":"trace[1645318914] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"451.572887ms","start":"2026-02-05T17:40:46.421723Z","end":"2026-02-05T17:40:46.873296Z","steps":["trace[1645318914] 'process raft request' (duration: 451.218885ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.873482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.421716Z","time spent":"451.66608ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:40:46.87382Z","caller":"traceutil/trace.go:171","msg":"trace[1976330816] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"430.230565ms","start":"2026-02-05T17:40:46.443575Z","end":"2026-02-05T17:40:46.873805Z","steps":["trace[1976330816] 'process raft request' (duration: 429.519571ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.873894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.443559Z","time spent":"430.295857ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T17:40:46.874142Z","caller":"traceutil/trace.go:171","msg":"trace[1307248470] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"428.495217ms","start":"2026-02-05T17:40:46.445633Z","end":"2026-02-05T17:40:46.874128Z","steps":["trace[1307248470] 'process raft request' (duration: 427.722371ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.874227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.445627Z","time spent":"428.566429ms","remote":"127.0.0.1:58646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17396,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:46.884468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.463411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:46.884536Z","caller":"traceutil/trace.go:171","msg":"trace[1524561596] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:533; }","duration":"462.560413ms","start":"2026-02-05T17:40:46.421951Z","end":"2026-02-05T17:40:46.884511Z","steps":["trace[1524561596] 'agreement among raft nodes before linearized reading' (duration: 462.45282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.884561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.421946Z","time spent":"462.610036ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-02-05T17:40:46.884815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.10753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:46.884844Z","caller":"traceutil/trace.go:171","msg":"trace[800100977] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:533; }","duration":"109.149261ms","start":"2026-02-05T17:40:46.775689Z","end":"2026-02-05T17:40:46.884838Z","steps":["trace[800100977] 'agreement among raft nodes before linearized reading' (duration: 109.10881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.884928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.354235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:46.884941Z","caller":"traceutil/trace.go:171","msg":"trace[1239882859] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:533; }","duration":"117.367726ms","start":"2026-02-05T17:40:46.767569Z","end":"2026-02-05T17:40:46.884937Z","steps":["trace[1239882859] 'agreement among raft nodes before linearized reading' (duration: 117.330754ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.885035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.855986ms","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-05T17:40:46.88505Z","caller":"traceutil/trace.go:171","msg":"trace[1329322345] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:533; }","duration":"317.906997ms","start":"2026-02-05T17:40:46.567138Z","end":"2026-02-05T17:40:46.885045Z","steps":["trace[1329322345] 'agreement among raft nodes before linearized reading' (duration: 317.883876ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.885063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.56712Z","time spent":"317.940179ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-05T17:40:46.885138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.521738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:46.88515Z","caller":"traceutil/trace.go:171","msg":"trace[1989792762] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:533; }","duration":"440.542339ms","start":"2026-02-05T17:40:46.444604Z","end":"2026-02-05T17:40:46.885146Z","steps":["trace[1989792762] 'agreement among raft nodes before linearized reading' (duration: 440.523628ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.885175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.444601Z","time spent":"440.557279ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-02-05T17:40:46.88523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.628582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:46.885255Z","caller":"traceutil/trace.go:171","msg":"trace[967406198] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:533; }","duration":"440.670163ms","start":"2026-02-05T17:40:46.444582Z","end":"2026-02-05T17:40:46.885252Z","steps":["trace[967406198] 'agreement among raft nodes before linearized reading' (duration: 440.636912ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.885268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.44458Z","time spent":"440.685134ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-05T17:40:46.885333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.754606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:46.885346Z","caller":"traceutil/trace.go:171","msg":"trace[968685176] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:533; }","duration":"440.772237ms","start":"2026-02-05T17:40:46.444569Z","end":"2026-02-05T17:40:46.885342Z","steps":["trace[968685176] 'agreement among raft nodes before linearized reading' (duration: 440.739606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.885357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.444567Z","time spent":"440.787518ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-02-05T17:40:46.885423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.85616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:46.885435Z","caller":"traceutil/trace.go:171","msg":"trace[1333597968] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:533; }","duration":"440.87426ms","start":"2026-02-05T17:40:46.444557Z","end":"2026-02-05T17:40:46.885431Z","steps":["trace[1333597968] 'agreement among raft nodes before linearized reading' (duration: 440.8557ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.885446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.444554Z","time spent":"440.889211ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-02-05T17:40:46.886213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.666597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:46.886231Z","caller":"traceutil/trace.go:171","msg":"trace[1130677773] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:533; }","duration":"441.715909ms","start":"2026-02-05T17:40:46.444511Z","end":"2026-02-05T17:40:46.886226Z","steps":["trace[1130677773] 'agreement among raft nodes before linearized reading' (duration: 441.683558ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.886259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.444505Z","time spent":"441.74948ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-02-05T17:40:46.886373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.389354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:46.886388Z","caller":"traceutil/trace.go:171","msg":"trace[922177767] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:533; }","duration":"464.411076ms","start":"2026-02-05T17:40:46.421973Z","end":"2026-02-05T17:40:46.886384Z","steps":["trace[922177767] 'agreement among raft nodes before linearized reading' (duration: 464.336743ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:46.886402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:46.421971Z","time spent":"464.428026ms","remote":"127.0.0.1:58500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"info","ts":"2026-02-05T17:40:48.867013Z","caller":"traceutil/trace.go:171","msg":"trace[721258620] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"123.441669ms","start":"2026-02-05T17:40:48.743551Z","end":"2026-02-05T17:40:48.866993Z","steps":["trace[721258620] 'process raft request' (duration: 123.137819ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:48.871054Z","caller":"traceutil/trace.go:171","msg":"trace[394802395] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"100.643678ms","start":"2026-02-05T17:40:48.770401Z","end":"2026-02-05T17:40:48.871045Z","steps":["trace[394802395] 'process raft request' (duration: 100.583996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:58.419188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.244298ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:40:58.419339Z","caller":"traceutil/trace.go:171","msg":"trace[998426675] linearizableReadLoop","detail":"{readStateIndex:695; appliedIndex:692; }","duration":"619.903147ms","start":"2026-02-05T17:40:57.799424Z","end":"2026-02-05T17:40:58.419327Z","steps":["trace[998426675] 'read index received' (duration: 414.465844ms)","trace[998426675] 'applied index is now lower than readState.Index' (duration: 205.436733ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:40:58.419388Z","caller":"traceutil/trace.go:171","msg":"trace[705632674] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"659.682066ms","start":"2026-02-05T17:40:57.759681Z","end":"2026-02-05T17:40:58.419363Z","steps":["trace[705632674] 'process raft request' (duration: 659.573383ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:40:58.419462Z","caller":"traceutil/trace.go:171","msg":"trace[1870450173] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"654.989448ms","start":"2026-02-05T17:40:57.764465Z","end":"2026-02-05T17:40:58.419454Z","steps":["trace[1870450173] 'process raft request' (duration: 654.832134ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:58.419523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:57.764458Z","time spent":"655.04263ms","remote":"127.0.0.1:58908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3866,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:58.419527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:57.759677Z","time spent":"659.775238ms","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1018,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:58.419644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.106236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:58.419664Z","caller":"traceutil/trace.go:171","msg":"trace[882526429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:670; }","duration":"643.161128ms","start":"2026-02-05T17:40:57.776496Z","end":"2026-02-05T17:40:58.419657Z","steps":["trace[882526429] 'agreement among raft nodes before linearized reading' (duration: 643.130177ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:58.419691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:57.776475Z","time spent":"643.203519ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-05T17:40:58.419793Z","caller":"traceutil/trace.go:171","msg":"trace[935235752] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"660.19881ms","start":"2026-02-05T17:40:57.759584Z","end":"2026-02-05T17:40:58.419782Z","steps":["trace[935235752] 'process raft request' (duration: 454.298204ms)","trace[935235752] 'compare' (duration: 205.084354ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:40:58.419859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:57.759568Z","time spent":"660.246401ms","remote":"127.0.0.1:58732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1613,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:58.919703Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148893456197523,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T17:40:59.420078Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148893456197523,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T17:40:59.645636Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.431799814s","expected-duration":"1s"} {"level":"info","ts":"2026-02-05T17:40:59.690402Z","caller":"traceutil/trace.go:171","msg":"trace[431530201] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:695; }","duration":"1.271023013s","start":"2026-02-05T17:40:58.419358Z","end":"2026-02-05T17:40:59.690381Z","steps":["trace[431530201] 'read index received' (duration: 1.226417383s)","trace[431530201] 'applied index is now lower than readState.Index' (duration: 44.60482ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:40:59.690876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.570937118s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-05T17:40:59.690939Z","caller":"traceutil/trace.go:171","msg":"trace[430176625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:672; }","duration":"1.571038551s","start":"2026-02-05T17:40:58.119883Z","end":"2026-02-05T17:40:59.690922Z","steps":["trace[430176625] 'agreement among raft nodes before linearized reading' (duration: 1.570840256s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:59.690972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:58.119867Z","time spent":"1.571099373s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-05T17:40:59.691207Z","caller":"traceutil/trace.go:171","msg":"trace[303224285] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"1.883703713s","start":"2026-02-05T17:40:57.807492Z","end":"2026-02-05T17:40:59.691196Z","steps":["trace[303224285] 'process raft request' (duration: 1.838337092s)","trace[303224285] 'compare' (duration: 43.149431ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:40:59.691271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:57.807477Z","time spent":"1.883748045s","remote":"127.0.0.1:58908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3830,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:40:59.691454Z","caller":"traceutil/trace.go:171","msg":"trace[589342185] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"1.882653925s","start":"2026-02-05T17:40:57.80879Z","end":"2026-02-05T17:40:59.691444Z","steps":["trace[589342185] 'process raft request' (duration: 1.881530734s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:59.69149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:57.808784Z","time spent":"1.882685845s","remote":"127.0.0.1:58892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4191,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:40:59.691611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.566166359s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-05T17:40:59.691629Z","caller":"traceutil/trace.go:171","msg":"trace[668149862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:672; }","duration":"1.566194971s","start":"2026-02-05T17:40:58.125428Z","end":"2026-02-05T17:40:59.691623Z","steps":["trace[668149862] 'agreement among raft nodes before linearized reading' (duration: 1.566139859s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:59.69165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:58.125419Z","time spent":"1.566226881s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-05T17:40:59.692036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.595801814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-05T17:40:59.692056Z","caller":"traceutil/trace.go:171","msg":"trace[1534213141] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:672; }","duration":"1.595844004s","start":"2026-02-05T17:40:58.096206Z","end":"2026-02-05T17:40:59.69205Z","steps":["trace[1534213141] 'agreement among raft nodes before linearized reading' (duration: 1.595785663s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:59.692074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:58.096186Z","time spent":"1.595884066s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-05T17:40:59.692181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.575528234s","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-05T17:40:59.692198Z","caller":"traceutil/trace.go:171","msg":"trace[392400499] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:672; }","duration":"1.575560244s","start":"2026-02-05T17:40:58.116632Z","end":"2026-02-05T17:40:59.692192Z","steps":["trace[392400499] 'agreement among raft nodes before linearized reading' (duration: 1.575511973s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:59.692213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:58.1166Z","time spent":"1.575609425s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-05T17:40:59.69242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.268887154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:40:59.692439Z","caller":"traceutil/trace.go:171","msg":"trace[855669214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:672; }","duration":"1.268929326s","start":"2026-02-05T17:40:58.423504Z","end":"2026-02-05T17:40:59.692433Z","steps":["trace[855669214] 'agreement among raft nodes before linearized reading' (duration: 1.268899765s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:59.692455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:58.42349Z","time spent":"1.268961906s","remote":"127.0.0.1:58474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T17:40:59.692573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.013845ms","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-05T17:40:59.69259Z","caller":"traceutil/trace.go:171","msg":"trace[758961610] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:672; }","duration":"688.051397ms","start":"2026-02-05T17:40:59.004533Z","end":"2026-02-05T17:40:59.692584Z","steps":["trace[758961610] 'agreement among raft nodes before linearized reading' (duration: 688.002965ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:59.692606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:59.004518Z","time spent":"688.084697ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-05T17:40:59.692693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.356046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-05T17:40:59.692711Z","caller":"traceutil/trace.go:171","msg":"trace[1695630075] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:672; }","duration":"820.399977ms","start":"2026-02-05T17:40:58.872306Z","end":"2026-02-05T17:40:59.692706Z","steps":["trace[1695630075] 'agreement among raft nodes before linearized reading' (duration: 820.366216ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:59.692729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:58.872291Z","time spent":"820.432468ms","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":4,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-02-05T17:40:59.692822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.695034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-05T17:40:59.692841Z","caller":"traceutil/trace.go:171","msg":"trace[68354188] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:672; }","duration":"984.713124ms","start":"2026-02-05T17:40:58.708121Z","end":"2026-02-05T17:40:59.692834Z","steps":["trace[68354188] 'agreement among raft nodes before linearized reading' (duration: 984.682594ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:40:59.692859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:58.708062Z","time spent":"984.791387ms","remote":"127.0.0.1:58884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-05T17:41:00.208542Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148893456197526,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T17:41:00.709367Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148893456197526,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T17:41:01.010741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.986079ms","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-05T17:41:01.010867Z","caller":"traceutil/trace.go:171","msg":"trace[1520648093] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:672; }","duration":"707.121953ms","start":"2026-02-05T17:41:00.303728Z","end":"2026-02-05T17:41:01.01085Z","steps":["trace[1520648093] 'range keys from in-memory index tree' (duration: 706.951259ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:01.01206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.717594ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:41:01.012094Z","caller":"traceutil/trace.go:171","msg":"trace[233770615] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"1.304968183s","start":"2026-02-05T17:40:59.707118Z","end":"2026-02-05T17:41:01.012086Z","steps":["trace[233770615] 'process raft request' (duration: 1.020188657s)","trace[233770615] 'compare' (duration: 284.063226ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:41:01.01212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:59.707098Z","time spent":"1.305009283s","remote":"127.0.0.1:58892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4164,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:41:01.277231Z","caller":"traceutil/trace.go:171","msg":"trace[1317640033] linearizableReadLoop","detail":"{readStateIndex:705; appliedIndex:697; }","duration":"1.569000945s","start":"2026-02-05T17:40:59.708213Z","end":"2026-02-05T17:41:01.277213Z","steps":["trace[1317640033] 'read index received' (duration: 1.019099767s)","trace[1317640033] 'applied index is now lower than readState.Index' (duration: 549.900288ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:41:01.27727Z","caller":"traceutil/trace.go:171","msg":"trace[642982607] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"1.568828861s","start":"2026-02-05T17:40:59.708423Z","end":"2026-02-05T17:41:01.277252Z","steps":["trace[642982607] 'process raft request' (duration: 1.568702168s)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:01.277319Z","caller":"traceutil/trace.go:171","msg":"trace[1742680719] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"1.567930767s","start":"2026-02-05T17:40:59.709379Z","end":"2026-02-05T17:41:01.27731Z","steps":["trace[1742680719] 'process raft request' (duration: 1.567761322s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:01.27737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:59.708417Z","time spent":"1.568905023s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:41:01.2774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:59.709373Z","time spent":"1.567966968s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:41:01.277556Z","caller":"traceutil/trace.go:171","msg":"trace[1338929913] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"1.568137682s","start":"2026-02-05T17:40:59.709413Z","end":"2026-02-05T17:41:01.27755Z","steps":["trace[1338929913] 'process raft request' (duration: 1.567743422s)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:01.277575Z","caller":"traceutil/trace.go:171","msg":"trace[1315473526] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"1.569308424s","start":"2026-02-05T17:40:59.708261Z","end":"2026-02-05T17:41:01.277569Z","steps":["trace[1315473526] 'process raft request' (duration: 1.568759249s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:01.277585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:59.709409Z","time spent":"1.568160603s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:41:01.277605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:59.708253Z","time spent":"1.569335874s","remote":"127.0.0.1:58646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4808,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:41:01.277664Z","caller":"traceutil/trace.go:171","msg":"trace[395223861] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"1.568092301s","start":"2026-02-05T17:40:59.709567Z","end":"2026-02-05T17:41:01.277659Z","steps":["trace[395223861] 'process raft request' (duration: 1.567604468s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:01.277689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:59.709561Z","time spent":"1.568114672s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:41:01.27772Z","caller":"traceutil/trace.go:171","msg":"trace[834096584] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"1.569323504s","start":"2026-02-05T17:40:59.708391Z","end":"2026-02-05T17:41:01.277714Z","steps":["trace[834096584] 'process raft request' (duration: 1.568710477s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:01.277747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:59.708386Z","time spent":"1.569345685s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:41:01.277755Z","caller":"traceutil/trace.go:171","msg":"trace[427413430] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"728.206836ms","start":"2026-02-05T17:41:00.549544Z","end":"2026-02-05T17:41:01.277751Z","steps":["trace[427413430] 'process raft request' (duration: 727.64215ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:01.277782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:00.549509Z","time spent":"728.256757ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:41:01.27783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.569616192s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:41:01.277846Z","caller":"traceutil/trace.go:171","msg":"trace[170714710] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"1.569641923s","start":"2026-02-05T17:40:59.7082Z","end":"2026-02-05T17:41:01.277841Z","steps":["trace[170714710] 'agreement among raft nodes before linearized reading' (duration: 1.569614652s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:01.277873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:59.708193Z","time spent":"1.569676504s","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T17:41:01.277952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.510367255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-05T17:41:01.277965Z","caller":"traceutil/trace.go:171","msg":"trace[666278770] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:680; }","duration":"1.510419956s","start":"2026-02-05T17:40:59.767541Z","end":"2026-02-05T17:41:01.277961Z","steps":["trace[666278770] 'agreement among raft nodes before linearized reading' (duration: 1.510397786s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:01.277976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:40:59.76752Z","time spent":"1.510453318s","remote":"127.0.0.1:58630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-02-05T17:41:01.278171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.299691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:41:01.278184Z","caller":"traceutil/trace.go:171","msg":"trace[2136385380] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"100.340711ms","start":"2026-02-05T17:41:01.17784Z","end":"2026-02-05T17:41:01.27818Z","steps":["trace[2136385380] 'agreement among raft nodes before linearized reading' (duration: 100.319531ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:01.278289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.920145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4179"} {"level":"info","ts":"2026-02-05T17:41:01.278307Z","caller":"traceutil/trace.go:171","msg":"trace[122773055] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:680; }","duration":"254.967517ms","start":"2026-02-05T17:41:01.023333Z","end":"2026-02-05T17:41:01.2783Z","steps":["trace[122773055] 'agreement among raft nodes before linearized reading' (duration: 254.916345ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:04.455132Z","caller":"traceutil/trace.go:171","msg":"trace[1599129030] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"178.355919ms","start":"2026-02-05T17:41:04.276746Z","end":"2026-02-05T17:41:04.455102Z","steps":["trace[1599129030] 'process raft request' (duration: 178.149123ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:09.54881Z","caller":"traceutil/trace.go:171","msg":"trace[1023017655] linearizableReadLoop","detail":"{readStateIndex:739; appliedIndex:738; }","duration":"205.813162ms","start":"2026-02-05T17:41:09.342971Z","end":"2026-02-05T17:41:09.548784Z","steps":["trace[1023017655] 'read index received' (duration: 205.616737ms)","trace[1023017655] 'applied index is now lower than readState.Index' (duration: 195.255µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:41:09.549031Z","caller":"traceutil/trace.go:171","msg":"trace[353996510] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"215.168953ms","start":"2026-02-05T17:41:09.333851Z","end":"2026-02-05T17:41:09.54902Z","steps":["trace[353996510] 'process raft request' (duration: 214.800643ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:09.549292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.292585ms","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-05T17:41:09.549317Z","caller":"traceutil/trace.go:171","msg":"trace[1508274048] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:712; }","duration":"206.377407ms","start":"2026-02-05T17:41:09.342933Z","end":"2026-02-05T17:41:09.54931Z","steps":["trace[1508274048] 'agreement among raft nodes before linearized reading' (duration: 206.236844ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:09.549464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.461602ms","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-05T17:41:09.549481Z","caller":"traceutil/trace.go:171","msg":"trace[430946237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:712; }","duration":"199.490773ms","start":"2026-02-05T17:41:09.349984Z","end":"2026-02-05T17:41:09.549475Z","steps":["trace[430946237] 'agreement among raft nodes before linearized reading' (duration: 199.435341ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:09.549632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.495366ms","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-05T17:41:09.54965Z","caller":"traceutil/trace.go:171","msg":"trace[898907414] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:712; }","duration":"198.523747ms","start":"2026-02-05T17:41:09.35112Z","end":"2026-02-05T17:41:09.549644Z","steps":["trace[898907414] 'agreement among raft nodes before linearized reading' (duration: 198.465106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:09.549777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.654808ms","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-05T17:41:09.549796Z","caller":"traceutil/trace.go:171","msg":"trace[1423985810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:712; }","duration":"199.704509ms","start":"2026-02-05T17:41:09.350085Z","end":"2026-02-05T17:41:09.549789Z","steps":["trace[1423985810] 'agreement among raft nodes before linearized reading' (duration: 199.648688ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:23.972796Z","caller":"traceutil/trace.go:171","msg":"trace[952488067] linearizableReadLoop","detail":"{readStateIndex:782; appliedIndex:781; }","duration":"287.654884ms","start":"2026-02-05T17:41:23.685126Z","end":"2026-02-05T17:41:23.972781Z","steps":["trace[952488067] 'read index received' (duration: 287.530051ms)","trace[952488067] 'applied index is now lower than readState.Index' (duration: 122.723µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:41:23.972982Z","caller":"traceutil/trace.go:171","msg":"trace[1580421628] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"352.411048ms","start":"2026-02-05T17:41:23.620565Z","end":"2026-02-05T17:41:23.972976Z","steps":["trace[1580421628] 'process raft request' (duration: 352.133681ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:23.973042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:23.620554Z","time spent":"352.443139ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:41:23.97318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.052975ms","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-05T17:41:23.973195Z","caller":"traceutil/trace.go:171","msg":"trace[1036444124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"288.093686ms","start":"2026-02-05T17:41:23.685096Z","end":"2026-02-05T17:41:23.97319Z","steps":["trace[1036444124] 'agreement among raft nodes before linearized reading' (duration: 288.031744ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:23.973277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.099261ms","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-05T17:41:23.97329Z","caller":"traceutil/trace.go:171","msg":"trace[1646742342] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:752; }","duration":"283.111162ms","start":"2026-02-05T17:41:23.690174Z","end":"2026-02-05T17:41:23.973285Z","steps":["trace[1646742342] 'agreement among raft nodes before linearized reading' (duration: 283.076541ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:23.9734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.290331ms","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-05T17:41:23.973413Z","caller":"traceutil/trace.go:171","msg":"trace[1052410129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:752; }","duration":"282.314361ms","start":"2026-02-05T17:41:23.691093Z","end":"2026-02-05T17:41:23.973408Z","steps":["trace[1052410129] 'agreement among raft nodes before linearized reading' (duration: 282.27892ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:23.973483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.279837ms","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-05T17:41:23.973515Z","caller":"traceutil/trace.go:171","msg":"trace[1233943100] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:752; }","duration":"283.320668ms","start":"2026-02-05T17:41:23.69019Z","end":"2026-02-05T17:41:23.973511Z","steps":["trace[1233943100] 'agreement among raft nodes before linearized reading' (duration: 283.270276ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:27.101192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.417456ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-05T17:41:27.101299Z","caller":"traceutil/trace.go:171","msg":"trace[2145835201] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:792; }","duration":"324.342036ms","start":"2026-02-05T17:41:26.776939Z","end":"2026-02-05T17:41:27.101281Z","steps":["trace[2145835201] 'read index received' (duration: 104.694044ms)","trace[2145835201] 'applied index is now lower than readState.Index' (duration: 219.646212ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:41:27.101429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.47442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:41:27.101452Z","caller":"traceutil/trace.go:171","msg":"trace[785478952] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:762; }","duration":"324.531592ms","start":"2026-02-05T17:41:26.776911Z","end":"2026-02-05T17:41:27.101443Z","steps":["trace[785478952] 'agreement among raft nodes before linearized reading' (duration: 324.46174ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:27.10148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:26.776897Z","time spent":"324.577762ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T17:41:27.101787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.625043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:41:27.101808Z","caller":"traceutil/trace.go:171","msg":"trace[552783959] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:762; }","duration":"278.649763ms","start":"2026-02-05T17:41:26.823153Z","end":"2026-02-05T17:41:27.101803Z","steps":["trace[552783959] 'agreement among raft nodes before linearized reading' (duration: 278.612492ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:28.362801Z","caller":"traceutil/trace.go:171","msg":"trace[464954104] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"124.955545ms","start":"2026-02-05T17:41:28.237822Z","end":"2026-02-05T17:41:28.362777Z","steps":["trace[464954104] 'process raft request' (duration: 124.808691ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:28.530028Z","caller":"traceutil/trace.go:171","msg":"trace[716483316] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"285.746962ms","start":"2026-02-05T17:41:28.244252Z","end":"2026-02-05T17:41:28.529999Z","steps":["trace[716483316] 'process raft request' (duration: 285.713381ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:28.530928Z","caller":"traceutil/trace.go:171","msg":"trace[1452163049] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"287.397236ms","start":"2026-02-05T17:41:28.243517Z","end":"2026-02-05T17:41:28.530914Z","steps":["trace[1452163049] 'process raft request' (duration: 286.42088ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:28.530929Z","caller":"traceutil/trace.go:171","msg":"trace[903080617] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"288.708951ms","start":"2026-02-05T17:41:28.242178Z","end":"2026-02-05T17:41:28.530887Z","steps":["trace[903080617] 'process raft request' (duration: 287.721915ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:28.531234Z","caller":"traceutil/trace.go:171","msg":"trace[1076103463] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"293.308884ms","start":"2026-02-05T17:41:28.237917Z","end":"2026-02-05T17:41:28.531226Z","steps":["trace[1076103463] 'process raft request' (duration: 291.795963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:29.156024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.33742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:41:29.156103Z","caller":"traceutil/trace.go:171","msg":"trace[1299197913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:767; }","duration":"376.462272ms","start":"2026-02-05T17:41:28.779622Z","end":"2026-02-05T17:41:29.156084Z","steps":["trace[1299197913] 'range keys from in-memory index tree' (duration: 375.760863ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:29.156137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:28.779534Z","time spent":"376.596856ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T17:41:42.08053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.366095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:41:42.080606Z","caller":"traceutil/trace.go:171","msg":"trace[1827138458] linearizableReadLoop","detail":"{readStateIndex:888; appliedIndex:887; }","duration":"300.297043ms","start":"2026-02-05T17:41:41.7803Z","end":"2026-02-05T17:41:42.080597Z","steps":["trace[1827138458] 'read index received' (duration: 23.171µs)","trace[1827138458] 'applied index is now lower than readState.Index' (duration: 300.273022ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:41:42.080744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.448587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:41:42.080768Z","caller":"traceutil/trace.go:171","msg":"trace[1489169667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:852; }","duration":"300.472117ms","start":"2026-02-05T17:41:41.78029Z","end":"2026-02-05T17:41:42.080762Z","steps":["trace[1489169667] 'agreement among raft nodes before linearized reading' (duration: 300.373835ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:42.080786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:41.780232Z","time spent":"300.54958ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T17:41:42.081397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.40312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-05T17:41:42.08142Z","caller":"traceutil/trace.go:171","msg":"trace[220735084] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:852; }","duration":"221.448061ms","start":"2026-02-05T17:41:41.859967Z","end":"2026-02-05T17:41:42.081415Z","steps":["trace[220735084] 'agreement among raft nodes before linearized reading' (duration: 221.41066ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:42.081515Z","caller":"traceutil/trace.go:171","msg":"trace[117518128] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"696.116265ms","start":"2026-02-05T17:41:41.385368Z","end":"2026-02-05T17:41:42.081484Z","steps":["trace[117518128] 'process raft request' (duration: 195.719322ms)","trace[117518128] 'compare' (duration: 498.943414ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:41:42.081562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.886355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:41:42.081581Z","caller":"traceutil/trace.go:171","msg":"trace[291105299] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:852; }","duration":"211.928206ms","start":"2026-02-05T17:41:41.869647Z","end":"2026-02-05T17:41:42.081575Z","steps":["trace[291105299] 'agreement among raft nodes before linearized reading' (duration: 211.899515ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:42.081646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:41.385355Z","time spent":"696.218727ms","remote":"127.0.0.1:58484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:41:42.645693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.524811ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:41:42.645761Z","caller":"traceutil/trace.go:171","msg":"trace[275045659] linearizableReadLoop","detail":"{readStateIndex:889; appliedIndex:888; }","duration":"215.985815ms","start":"2026-02-05T17:41:42.429763Z","end":"2026-02-05T17:41:42.645749Z","steps":["trace[275045659] 'read index received' (duration: 29.861µs)","trace[275045659] 'applied index is now lower than readState.Index' (duration: 215.955184ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:41:42.645921Z","caller":"traceutil/trace.go:171","msg":"trace[1718595066] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"520.652644ms","start":"2026-02-05T17:41:42.125258Z","end":"2026-02-05T17:41:42.645911Z","steps":["trace[1718595066] 'process raft request' (duration: 288.850316ms)","trace[1718595066] 'compare' (duration: 231.414488ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:41:42.645975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:42.125226Z","time spent":"520.727517ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:41:42.646248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.482178ms","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-05T17:41:42.646269Z","caller":"traceutil/trace.go:171","msg":"trace[1120884756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:853; }","duration":"216.52725ms","start":"2026-02-05T17:41:42.429736Z","end":"2026-02-05T17:41:42.646263Z","steps":["trace[1120884756] 'agreement among raft nodes before linearized reading' (duration: 216.466478ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:42.912659Z","caller":"traceutil/trace.go:171","msg":"trace[32519712] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"259.166361ms","start":"2026-02-05T17:41:42.653477Z","end":"2026-02-05T17:41:42.912643Z","steps":["trace[32519712] 'process raft request' (duration: 248.861035ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:42.924358Z","caller":"traceutil/trace.go:171","msg":"trace[1465331295] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"270.606267ms","start":"2026-02-05T17:41:42.653737Z","end":"2026-02-05T17:41:42.924343Z","steps":["trace[1465331295] 'process raft request' (duration: 270.578707ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:42.924482Z","caller":"traceutil/trace.go:171","msg":"trace[19542137] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"270.952037ms","start":"2026-02-05T17:41:42.653511Z","end":"2026-02-05T17:41:42.924463Z","steps":["trace[19542137] 'process raft request' (duration: 270.646648ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:42.924674Z","caller":"traceutil/trace.go:171","msg":"trace[352454728] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"270.964847ms","start":"2026-02-05T17:41:42.653702Z","end":"2026-02-05T17:41:42.924667Z","steps":["trace[352454728] 'process raft request' (duration: 270.579657ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:42.924714Z","caller":"traceutil/trace.go:171","msg":"trace[606070142] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"271.120101ms","start":"2026-02-05T17:41:42.653589Z","end":"2026-02-05T17:41:42.92471Z","steps":["trace[606070142] 'process raft request' (duration: 270.661399ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:51.18088Z","caller":"traceutil/trace.go:171","msg":"trace[962833549] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:911; }","duration":"200.714505ms","start":"2026-02-05T17:41:50.980142Z","end":"2026-02-05T17:41:51.180857Z","steps":["trace[962833549] 'read index received' (duration: 200.479759ms)","trace[962833549] 'applied index is now lower than readState.Index' (duration: 233.816µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:41:51.181264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.064685ms","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-05T17:41:51.181317Z","caller":"traceutil/trace.go:171","msg":"trace[2007436602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:875; }","duration":"201.206419ms","start":"2026-02-05T17:41:50.980098Z","end":"2026-02-05T17:41:51.181304Z","steps":["trace[2007436602] 'agreement among raft nodes before linearized reading' (duration: 200.928272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:51.181645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.723048ms","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-05T17:41:51.181677Z","caller":"traceutil/trace.go:171","msg":"trace[958888686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:875; }","duration":"193.76734ms","start":"2026-02-05T17:41:50.9879Z","end":"2026-02-05T17:41:51.181667Z","steps":["trace[958888686] 'agreement among raft nodes before linearized reading' (duration: 193.686398ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:51.181866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.996345ms","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-05T17:41:51.181892Z","caller":"traceutil/trace.go:171","msg":"trace[1292062122] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:875; }","duration":"191.042917ms","start":"2026-02-05T17:41:50.990841Z","end":"2026-02-05T17:41:51.181884Z","steps":["trace[1292062122] 'agreement among raft nodes before linearized reading' (duration: 190.899783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:51.181992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.993625ms","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-05T17:41:51.182013Z","caller":"traceutil/trace.go:171","msg":"trace[2073990715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:875; }","duration":"194.023037ms","start":"2026-02-05T17:41:50.987983Z","end":"2026-02-05T17:41:51.182006Z","steps":["trace[2073990715] 'agreement among raft nodes before linearized reading' (duration: 193.963935ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:51.18208Z","caller":"traceutil/trace.go:171","msg":"trace[31571045] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"237.200303ms","start":"2026-02-05T17:41:50.944871Z","end":"2026-02-05T17:41:51.182072Z","steps":["trace[31571045] 'process raft request' (duration: 235.807895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:55.46574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.356327ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:41:55.465809Z","caller":"traceutil/trace.go:171","msg":"trace[291932019] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"229.155348ms","start":"2026-02-05T17:41:55.236642Z","end":"2026-02-05T17:41:55.465797Z","steps":["trace[291932019] 'process raft request' (duration: 72.686347ms)","trace[291932019] 'compare' (duration: 156.244585ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:41:55.539822Z","caller":"traceutil/trace.go:171","msg":"trace[30105184] linearizableReadLoop","detail":"{readStateIndex:927; appliedIndex:925; }","duration":"296.46665ms","start":"2026-02-05T17:41:55.243339Z","end":"2026-02-05T17:41:55.539806Z","steps":["trace[30105184] 'read index received' (duration: 65.998097ms)","trace[30105184] 'applied index is now lower than readState.Index' (duration: 230.468043ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:41:55.540013Z","caller":"traceutil/trace.go:171","msg":"trace[52003841] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"300.868038ms","start":"2026-02-05T17:41:55.23914Z","end":"2026-02-05T17:41:55.540008Z","steps":["trace[52003841] 'process raft request' (duration: 300.57872ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:55.540079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:55.239132Z","time spent":"300.902249ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:41:55.540233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.890721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-05T17:41:55.540253Z","caller":"traceutil/trace.go:171","msg":"trace[117610808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:889; }","duration":"296.921011ms","start":"2026-02-05T17:41:55.243327Z","end":"2026-02-05T17:41:55.540248Z","steps":["trace[117610808] 'agreement among raft nodes before linearized reading' (duration: 296.85348ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:55.540341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.974034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-05T17:41:55.540358Z","caller":"traceutil/trace.go:171","msg":"trace[177556055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:889; }","duration":"296.999934ms","start":"2026-02-05T17:41:55.243354Z","end":"2026-02-05T17:41:55.540354Z","steps":["trace[177556055] 'agreement among raft nodes before linearized reading' (duration: 296.960003ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:55.540463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.048706ms","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-05T17:41:55.540484Z","caller":"traceutil/trace.go:171","msg":"trace[567034757] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:889; }","duration":"163.104108ms","start":"2026-02-05T17:41:55.377374Z","end":"2026-02-05T17:41:55.540478Z","steps":["trace[567034757] 'agreement among raft nodes before linearized reading' (duration: 163.074207ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:56.688472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.021377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T17:41:56.688586Z","caller":"traceutil/trace.go:171","msg":"trace[128937757] linearizableReadLoop","detail":"{readStateIndex:929; appliedIndex:927; }","duration":"913.240559ms","start":"2026-02-05T17:41:55.775335Z","end":"2026-02-05T17:41:56.688576Z","steps":["trace[128937757] 'read index received' (duration: 421.067007ms)","trace[128937757] 'applied index is now lower than readState.Index' (duration: 492.173002ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:41:56.688643Z","caller":"traceutil/trace.go:171","msg":"trace[67239789] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"1.143992399s","start":"2026-02-05T17:41:55.544644Z","end":"2026-02-05T17:41:56.688637Z","steps":["trace[67239789] 'process raft request' (duration: 651.752286ms)","trace[67239789] 'compare' (duration: 491.650887ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:41:56.688688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:55.544632Z","time spent":"1.14403972s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:41:56.688674Z","caller":"traceutil/trace.go:171","msg":"trace[53971147] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"156.481441ms","start":"2026-02-05T17:41:56.532149Z","end":"2026-02-05T17:41:56.68863Z","steps":["trace[53971147] 'process raft request' (duration: 156.411959ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:41:56.68879Z","caller":"traceutil/trace.go:171","msg":"trace[1961421855] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"1.143828125s","start":"2026-02-05T17:41:55.544957Z","end":"2026-02-05T17:41:56.688785Z","steps":["trace[1961421855] 'process raft request' (duration: 1.143574048s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:56.688819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:55.544952Z","time spent":"1.143853226s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:41:56.688883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.547607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:41:56.688895Z","caller":"traceutil/trace.go:171","msg":"trace[540658935] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:892; }","duration":"913.581338ms","start":"2026-02-05T17:41:55.775309Z","end":"2026-02-05T17:41:56.68889Z","steps":["trace[540658935] 'agreement among raft nodes before linearized reading' (duration: 913.542297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:56.688909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:55.775296Z","time spent":"913.611139ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T17:41:56.689006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.412952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-05T17:41:56.689021Z","caller":"traceutil/trace.go:171","msg":"trace[1017258840] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:892; }","duration":"758.426752ms","start":"2026-02-05T17:41:55.930588Z","end":"2026-02-05T17:41:56.689015Z","steps":["trace[1017258840] 'agreement among raft nodes before linearized reading' (duration: 758.394472ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:56.689034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:55.930534Z","time spent":"758.495964ms","remote":"127.0.0.1:58946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":23,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-02-05T17:41:56.68917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.359536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:41:56.68921Z","caller":"traceutil/trace.go:171","msg":"trace[1075830670] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:892; }","duration":"455.445018ms","start":"2026-02-05T17:41:56.233753Z","end":"2026-02-05T17:41:56.689198Z","steps":["trace[1075830670] 'agreement among raft nodes before linearized reading' (duration: 455.369486ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:41:56.689241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:41:56.233741Z","time spent":"455.490789ms","remote":"127.0.0.1:47816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-02-05T17:42:03.19136Z","caller":"traceutil/trace.go:171","msg":"trace[1347988469] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"445.900963ms","start":"2026-02-05T17:42:02.745437Z","end":"2026-02-05T17:42:03.191338Z","steps":["trace[1347988469] 'process raft request' (duration: 445.78048ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:03.19151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:02.74542Z","time spent":"446.006405ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:42:03.444467Z","caller":"traceutil/trace.go:171","msg":"trace[638132013] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"662.162974ms","start":"2026-02-05T17:42:02.782286Z","end":"2026-02-05T17:42:03.444449Z","steps":["trace[638132013] 'read index received' (duration: 409.738354ms)","trace[638132013] 'applied index is now lower than readState.Index' (duration: 252.42396ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:42:03.444625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.326368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:42:03.444675Z","caller":"traceutil/trace.go:171","msg":"trace[2047101722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:917; }","duration":"662.422921ms","start":"2026-02-05T17:42:02.782241Z","end":"2026-02-05T17:42:03.444664Z","steps":["trace[2047101722] 'agreement among raft nodes before linearized reading' (duration: 662.345139ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:03.444696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:02.782227Z","time spent":"662.464682ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T17:42:03.444717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.924242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-05T17:42:03.444743Z","caller":"traceutil/trace.go:171","msg":"trace[1603055596] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:917; }","duration":"209.993374ms","start":"2026-02-05T17:42:03.234742Z","end":"2026-02-05T17:42:03.444735Z","steps":["trace[1603055596] 'agreement among raft nodes before linearized reading' (duration: 209.896991ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T17:42:03.444948Z","caller":"traceutil/trace.go:171","msg":"trace[96647057] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"402.91493ms","start":"2026-02-05T17:42:03.042027Z","end":"2026-02-05T17:42:03.444942Z","steps":["trace[96647057] 'process raft request' (duration: 402.364406ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:03.445003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:03.042011Z","time spent":"402.953841ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:42:03.445083Z","caller":"traceutil/trace.go:171","msg":"trace[1248319991] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"699.440172ms","start":"2026-02-05T17:42:02.745636Z","end":"2026-02-05T17:42:03.445076Z","steps":["trace[1248319991] 'process raft request' (duration: 669.267284ms)","trace[1248319991] 'compare' (duration: 29.309535ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:42:03.445114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:02.74563Z","time spent":"699.467043ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T17:42:15.995384Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148893456198271,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T17:42:16.554881Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988148893456198271,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T17:42:16.70237Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.461273849s","expected-duration":"1s"} {"level":"info","ts":"2026-02-05T17:42:16.755956Z","caller":"traceutil/trace.go:171","msg":"trace[1112530758] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"1.514907096s","start":"2026-02-05T17:42:15.241026Z","end":"2026-02-05T17:42:16.755933Z","steps":["trace[1112530758] 'process raft request' (duration: 1.514770802s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:16.756088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:15.241017Z","time spent":"1.514991288s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T17:42:16.828328Z","caller":"traceutil/trace.go:171","msg":"trace[1049684600] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1027; }","duration":"1.333726559s","start":"2026-02-05T17:42:15.494539Z","end":"2026-02-05T17:42:16.828265Z","steps":["trace[1049684600] 'read index received' (duration: 1.261967343s)","trace[1049684600] 'applied index is now lower than readState.Index' (duration: 71.757556ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:42:16.828608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.334036077s","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-05T17:42:16.829166Z","caller":"traceutil/trace.go:171","msg":"trace[346312326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:985; }","duration":"1.334647034s","start":"2026-02-05T17:42:15.494501Z","end":"2026-02-05T17:42:16.829148Z","steps":["trace[346312326] 'agreement among raft nodes before linearized reading' (duration: 1.333884323s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:16.829516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:15.494481Z","time spent":"1.335013174s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-05T17:42:16.830265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.311196542s","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-05T17:42:16.830336Z","caller":"traceutil/trace.go:171","msg":"trace[1066733507] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:985; }","duration":"1.311267433s","start":"2026-02-05T17:42:15.519058Z","end":"2026-02-05T17:42:16.830326Z","steps":["trace[1066733507] 'agreement among raft nodes before linearized reading' (duration: 1.31113567s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:16.830374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:15.519011Z","time spent":"1.311355857s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-05T17:42:16.830665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.135665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-02-05T17:42:16.830715Z","caller":"traceutil/trace.go:171","msg":"trace[1409908285] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:985; }","duration":"336.333281ms","start":"2026-02-05T17:42:16.494372Z","end":"2026-02-05T17:42:16.830705Z","steps":["trace[1409908285] 'agreement among raft nodes before linearized reading' (duration: 336.207057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:16.830877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:16.494353Z","time spent":"336.510275ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-05T17:42:16.831247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05160486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:42:16.831324Z","caller":"traceutil/trace.go:171","msg":"trace[867505376] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:985; }","duration":"1.051705173s","start":"2026-02-05T17:42:15.779606Z","end":"2026-02-05T17:42:16.831311Z","steps":["trace[867505376] 'agreement among raft nodes before linearized reading' (duration: 1.051562059s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:16.831407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:15.779589Z","time spent":"1.051810976s","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-05T17:42:16.831644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.150563479s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T17:42:16.831716Z","caller":"traceutil/trace.go:171","msg":"trace[406357019] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:985; }","duration":"1.150667842s","start":"2026-02-05T17:42:15.681018Z","end":"2026-02-05T17:42:16.831686Z","steps":["trace[406357019] 'agreement among raft nodes before linearized reading' (duration: 1.15057637s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:16.831821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:15.681Z","time spent":"1.150809125s","remote":"127.0.0.1:47772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-02-05T17:42:16.832065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.219470467s","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-05T17:42:16.832132Z","caller":"traceutil/trace.go:171","msg":"trace[248441682] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:985; }","duration":"1.21955111s","start":"2026-02-05T17:42:15.612573Z","end":"2026-02-05T17:42:16.832124Z","steps":["trace[248441682] 'agreement among raft nodes before linearized reading' (duration: 1.219421906s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:16.832195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:15.612564Z","time spent":"1.219622992s","remote":"127.0.0.1:58730","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-05T17:42:16.832444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26032009s","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-05T17:42:16.832524Z","caller":"traceutil/trace.go:171","msg":"trace[159265958] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:985; }","duration":"1.260439043s","start":"2026-02-05T17:42:15.57205Z","end":"2026-02-05T17:42:16.83249Z","steps":["trace[159265958] 'agreement among raft nodes before linearized reading' (duration: 1.260308519s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T17:42:16.832627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:42:15.572029Z","time spent":"1.260587617s","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-05T17:45:31.469523Z","caller":"traceutil/trace.go:171","msg":"trace[960604465] linearizableReadLoop","detail":"{readStateIndex:1912; appliedIndex:1911; }","duration":"229.828214ms","start":"2026-02-05T17:45:31.239666Z","end":"2026-02-05T17:45:31.469495Z","steps":["trace[960604465] 'read index received' (duration: 163.031457ms)","trace[960604465] 'applied index is now lower than readState.Index' (duration: 66.795397ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T17:45:31.470759Z","caller":"traceutil/trace.go:171","msg":"trace[1197380253] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"248.655451ms","start":"2026-02-05T17:45:31.222075Z","end":"2026-02-05T17:45:31.470731Z","steps":["trace[1197380253] 'process raft request' (duration: 180.712513ms)","trace[1197380253] 'compare' (duration: 66.216782ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T17:45:31.473392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.709438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-05T17:45:31.473427Z","caller":"traceutil/trace.go:171","msg":"trace[18425232] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:1830; }","duration":"233.77872ms","start":"2026-02-05T17:45:31.239637Z","end":"2026-02-05T17:45:31.473416Z","steps":["trace[18425232] 'agreement among raft nodes before linearized reading' (duration: 233.589135ms)"],"step_count":1}