{"level":"warn","ts":"2026-02-02T23:49:13.719909Z","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-02T23:49:13.720011Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.206:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.206:2380","--initial-cluster=instance=https://162.253.55.206:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.206:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.206: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-02T23:49:13.724261Z","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-02T23:49:13.724279Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.206:2380"]} {"level":"info","ts":"2026-02-02T23:49:13.724315Z","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-02T23:49:13.725091Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"]} {"level":"info","ts":"2026-02-02T23:49:13.725218Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.206:2380"],"listen-peer-urls":["https://162.253.55.206:2380"],"advertise-client-urls":["https://162.253.55.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.206: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-02T23:49:13.73216Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.587872ms"} {"level":"info","ts":"2026-02-02T23:49:13.763715Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cfc9fec265e3384a","cluster-id":"9866fe2b0d49ed88"} {"level":"info","ts":"2026-02-02T23:49:13.763838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=()"} {"level":"info","ts":"2026-02-02T23:49:13.763889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became follower at term 0"} {"level":"info","ts":"2026-02-02T23:49:13.763903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cfc9fec265e3384a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-02T23:49:13.763913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became follower at term 1"} {"level":"info","ts":"2026-02-02T23:49:13.764033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=(14972778547056425034)"} {"level":"warn","ts":"2026-02-02T23:49:13.770746Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-02T23:49:13.780852Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-02T23:49:13.787969Z","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-02T23:49:13.789953Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cfc9fec265e3384a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-02T23:49:13.790749Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cfc9fec265e3384a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-02T23:49:13.790964Z","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-02T23:49:13.791048Z","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-02T23:49:13.791109Z","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-02T23:49:13.792045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=(14972778547056425034)"} {"level":"info","ts":"2026-02-02T23:49:13.792818Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9866fe2b0d49ed88","local-member-id":"cfc9fec265e3384a","added-peer-id":"cfc9fec265e3384a","added-peer-peer-urls":["https://162.253.55.206:2380"]} {"level":"info","ts":"2026-02-02T23:49:13.824912Z","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-02T23:49:13.826876Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cfc9fec265e3384a","initial-advertise-peer-urls":["https://162.253.55.206:2380"],"listen-peer-urls":["https://162.253.55.206:2380"],"advertise-client-urls":["https://162.253.55.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-02T23:49:13.826902Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-02T23:49:13.828508Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.206:2380"} {"level":"info","ts":"2026-02-02T23:49:13.828525Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.206:2380"} {"level":"info","ts":"2026-02-02T23:49:13.864455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a is starting a new election at term 1"} {"level":"info","ts":"2026-02-02T23:49:13.864525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became pre-candidate at term 1"} {"level":"info","ts":"2026-02-02T23:49:13.864613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a received MsgPreVoteResp from cfc9fec265e3384a at term 1"} {"level":"info","ts":"2026-02-02T23:49:13.864655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became candidate at term 2"} {"level":"info","ts":"2026-02-02T23:49:13.864684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a received MsgVoteResp from cfc9fec265e3384a at term 2"} {"level":"info","ts":"2026-02-02T23:49:13.864693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became leader at term 2"} {"level":"info","ts":"2026-02-02T23:49:13.864765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cfc9fec265e3384a elected leader cfc9fec265e3384a at term 2"} {"level":"info","ts":"2026-02-02T23:49:13.868722Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cfc9fec265e3384a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.206:2379]}","request-path":"/0/members/cfc9fec265e3384a/attributes","cluster-id":"9866fe2b0d49ed88","publish-timeout":"7s"} {"level":"info","ts":"2026-02-02T23:49:13.868863Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-02T23:49:13.869752Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T23:49:13.870163Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-02T23:49:13.873115Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-02T23:49:13.873175Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-02T23:49:13.879958Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-02T23:49:13.880886Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9866fe2b0d49ed88","local-member-id":"cfc9fec265e3384a","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T23:49:13.881021Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T23:49:13.881058Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T23:49:13.88874Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.206:2379"} {"level":"warn","ts":"2026-02-02T23:49:24.837376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.008006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-02-02T23:49:24.837452Z","caller":"traceutil/trace.go:171","msg":"trace[2037977356] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:330; }","duration":"233.134288ms","start":"2026-02-02T23:49:24.604304Z","end":"2026-02-02T23:49:24.837438Z","steps":["trace[2037977356] 'range keys from in-memory index tree' (duration: 232.73736ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:24.837744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.46263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-02T23:49:24.837765Z","caller":"traceutil/trace.go:171","msg":"trace[301965497] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:330; }","duration":"212.505271ms","start":"2026-02-02T23:49:24.625255Z","end":"2026-02-02T23:49:24.83776Z","steps":["trace[301965497] 'range keys from in-memory index tree' (duration: 212.388089ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:24.837986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.404542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-02T23:49:24.838004Z","caller":"traceutil/trace.go:171","msg":"trace[708537088] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:330; }","duration":"156.420062ms","start":"2026-02-02T23:49:24.681577Z","end":"2026-02-02T23:49:24.837997Z","steps":["trace[708537088] 'range keys from in-memory index tree' (duration: 156.33088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:24.838145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.160551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-02T23:49:24.83816Z","caller":"traceutil/trace.go:171","msg":"trace[2131242864] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:330; }","duration":"113.216362ms","start":"2026-02-02T23:49:24.724939Z","end":"2026-02-02T23:49:24.838156Z","steps":["trace[2131242864] 'range keys from in-memory index tree' (duration: 113.10495ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:25.090238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.260783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-02T23:49:25.090434Z","caller":"traceutil/trace.go:171","msg":"trace[2054376425] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"240.581872ms","start":"2026-02-02T23:49:24.849832Z","end":"2026-02-02T23:49:25.090414Z","steps":["trace[2054376425] 'process raft request' (duration: 88.572452ms)","trace[2054376425] 'compare' (duration: 150.765271ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:49:25.09135Z","caller":"traceutil/trace.go:171","msg":"trace[1899904512] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"241.350819ms","start":"2026-02-02T23:49:24.849986Z","end":"2026-02-02T23:49:25.091336Z","steps":["trace[1899904512] 'process raft request' (duration: 240.387007ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:49:25.09198Z","caller":"traceutil/trace.go:171","msg":"trace[1285844170] linearizableReadLoop","detail":"{readStateIndex:340; appliedIndex:338; }","duration":"242.058586ms","start":"2026-02-02T23:49:24.849909Z","end":"2026-02-02T23:49:25.091967Z","steps":["trace[1285844170] 'read index received' (duration: 48.176446ms)","trace[1285844170] 'applied index is now lower than readState.Index' (duration: 193.857589ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:49:25.092457Z","caller":"traceutil/trace.go:171","msg":"trace[82320246] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"241.564914ms","start":"2026-02-02T23:49:24.850879Z","end":"2026-02-02T23:49:25.092444Z","steps":["trace[82320246] 'process raft request' (duration: 240.212183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:25.093115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.191202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-02-02T23:49:25.09356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.302615ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T23:49:25.093686Z","caller":"traceutil/trace.go:171","msg":"trace[460741408] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:334; }","duration":"145.439928ms","start":"2026-02-02T23:49:24.948225Z","end":"2026-02-02T23:49:25.093665Z","steps":["trace[460741408] 'agreement among raft nodes before linearized reading' (duration: 145.273804ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:49:25.093323Z","caller":"traceutil/trace.go:171","msg":"trace[300182030] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:334; }","duration":"243.429518ms","start":"2026-02-02T23:49:24.84988Z","end":"2026-02-02T23:49:25.09331Z","steps":["trace[300182030] 'agreement among raft nodes before linearized reading' (duration: 242.932067ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:49:30.582741Z","caller":"traceutil/trace.go:171","msg":"trace[1471975160] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"433.01243ms","start":"2026-02-02T23:49:30.149711Z","end":"2026-02-02T23:49:30.582724Z","steps":["trace[1471975160] 'process raft request' (duration: 432.864726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:30.582983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:30.149697Z","time spent":"433.097861ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T23:49:31.091688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.309603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-02T23:49:31.091775Z","caller":"traceutil/trace.go:171","msg":"trace[1761731410] linearizableReadLoop","detail":"{readStateIndex:391; appliedIndex:390; }","duration":"921.78527ms","start":"2026-02-02T23:49:30.169975Z","end":"2026-02-02T23:49:31.09176Z","steps":["trace[1761731410] 'read index received' (duration: 413.28438ms)","trace[1761731410] 'applied index is now lower than readState.Index' (duration: 508.49993ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:49:31.09197Z","caller":"traceutil/trace.go:171","msg":"trace[987099916] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"940.125839ms","start":"2026-02-02T23:49:30.15183Z","end":"2026-02-02T23:49:31.091956Z","steps":["trace[987099916] 'process raft request' (duration: 729.462207ms)","trace[987099916] 'compare' (duration: 210.193631ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:49:31.092025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:30.151821Z","time spent":"940.17555ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T23:49:31.092229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.246451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-02T23:49:31.092259Z","caller":"traceutil/trace.go:171","msg":"trace[1811556245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:381; }","duration":"922.290572ms","start":"2026-02-02T23:49:30.169959Z","end":"2026-02-02T23:49:31.09225Z","steps":["trace[1811556245] 'agreement among raft nodes before linearized reading' (duration: 922.20275ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:31.092286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:30.169952Z","time spent":"922.328423ms","remote":"127.0.0.1:43324","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-02T23:49:31.092442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.688092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T23:49:31.092475Z","caller":"traceutil/trace.go:171","msg":"trace[932391496] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:381; }","duration":"729.744923ms","start":"2026-02-02T23:49:30.362722Z","end":"2026-02-02T23:49:31.092467Z","steps":["trace[932391496] 'agreement among raft nodes before linearized reading' (duration: 729.690052ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:31.092499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:30.362711Z","time spent":"729.782854ms","remote":"127.0.0.1:43076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-02T23:49:31.092692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.166749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-02T23:49:31.092719Z","caller":"traceutil/trace.go:171","msg":"trace[1057641552] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:381; }","duration":"507.216801ms","start":"2026-02-02T23:49:30.585495Z","end":"2026-02-02T23:49:31.092711Z","steps":["trace[1057641552] 'agreement among raft nodes before linearized reading' (duration: 507.16577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:31.092745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:30.585484Z","time spent":"507.254132ms","remote":"127.0.0.1:43474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4058,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-02-02T23:49:44.75432Z","caller":"traceutil/trace.go:171","msg":"trace[1486589706] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"107.891599ms","start":"2026-02-02T23:49:44.646413Z","end":"2026-02-02T23:49:44.754305Z","steps":["trace[1486589706] 'process raft request' (duration: 107.805107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:45.476095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.182434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-02T23:49:45.476152Z","caller":"traceutil/trace.go:171","msg":"trace[481524836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:476; }","duration":"308.257816ms","start":"2026-02-02T23:49:45.167873Z","end":"2026-02-02T23:49:45.476131Z","steps":["trace[481524836] 'range keys from in-memory index tree' (duration: 308.119363ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:45.476184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:45.167859Z","time spent":"308.310247ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-02T23:49:45.476327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.55193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-02T23:49:45.476341Z","caller":"traceutil/trace.go:171","msg":"trace[1236050007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:476; }","duration":"307.574071ms","start":"2026-02-02T23:49:45.168762Z","end":"2026-02-02T23:49:45.476336Z","steps":["trace[1236050007] 'range keys from in-memory index tree' (duration: 307.490788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:45.476353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:45.168755Z","time spent":"307.595121ms","remote":"127.0.0.1:43324","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-02T23:49:45.47652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.076376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T23:49:45.476533Z","caller":"traceutil/trace.go:171","msg":"trace[1723559551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:476; }","duration":"116.113047ms","start":"2026-02-02T23:49:45.360416Z","end":"2026-02-02T23:49:45.476529Z","steps":["trace[1723559551] 'range keys from in-memory index tree' (duration: 115.998284ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:47.00203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.867189ms","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-02T23:49:47.002084Z","caller":"traceutil/trace.go:171","msg":"trace[1120469396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:480; }","duration":"243.972751ms","start":"2026-02-02T23:49:46.758097Z","end":"2026-02-02T23:49:47.00207Z","steps":["trace[1120469396] 'range keys from in-memory index tree' (duration: 243.728116ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:51.38737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.103836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-02T23:49:51.387445Z","caller":"traceutil/trace.go:171","msg":"trace[1575713975] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:493; }","duration":"367.26041ms","start":"2026-02-02T23:49:51.020168Z","end":"2026-02-02T23:49:51.387428Z","steps":["trace[1575713975] 'range keys from in-memory index tree' (duration: 366.913592ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:51.387495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:51.020144Z","time spent":"367.342212ms","remote":"127.0.0.1:43324","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-02T23:49:51.387948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.06461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wl8gk\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-02T23:49:51.387985Z","caller":"traceutil/trace.go:171","msg":"trace[1190177976] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wl8gk; range_end:; response_count:1; response_revision:493; }","duration":"150.125881ms","start":"2026-02-02T23:49:51.237849Z","end":"2026-02-02T23:49:51.387975Z","steps":["trace[1190177976] 'range keys from in-memory index tree' (duration: 149.964987ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:49:51.597138Z","caller":"traceutil/trace.go:171","msg":"trace[1479203669] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"205.553115ms","start":"2026-02-02T23:49:51.391567Z","end":"2026-02-02T23:49:51.59712Z","steps":["trace[1479203669] 'process raft request' (duration: 205.446922ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:49:51.981978Z","caller":"traceutil/trace.go:171","msg":"trace[359355151] linearizableReadLoop","detail":"{readStateIndex:509; appliedIndex:508; }","duration":"476.668875ms","start":"2026-02-02T23:49:51.505289Z","end":"2026-02-02T23:49:51.981957Z","steps":["trace[359355151] 'read index received' (duration: 92.182141ms)","trace[359355151] 'applied index is now lower than readState.Index' (duration: 384.485864ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:49:51.982303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.990103ms","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-02T23:49:51.982366Z","caller":"traceutil/trace.go:171","msg":"trace[297239155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:495; }","duration":"477.066045ms","start":"2026-02-02T23:49:51.505284Z","end":"2026-02-02T23:49:51.98235Z","steps":["trace[297239155] 'agreement among raft nodes before linearized reading' (duration: 476.88044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:51.98237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.10427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-02T23:49:51.982403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:51.505244Z","time spent":"477.151356ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-02T23:49:51.98241Z","caller":"traceutil/trace.go:171","msg":"trace[2878582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:495; }","duration":"475.168381ms","start":"2026-02-02T23:49:51.507229Z","end":"2026-02-02T23:49:51.982398Z","steps":["trace[2878582] 'agreement among raft nodes before linearized reading' (duration: 475.037128ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:51.982444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:51.507215Z","time spent":"475.221843ms","remote":"127.0.0.1:43324","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":"info","ts":"2026-02-02T23:49:51.982715Z","caller":"traceutil/trace.go:171","msg":"trace[972280805] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"581.120736ms","start":"2026-02-02T23:49:51.401584Z","end":"2026-02-02T23:49:51.982704Z","steps":["trace[972280805] 'process raft request' (duration: 580.190524ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:51.982792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:51.40157Z","time spent":"581.169596ms","remote":"127.0.0.1:43234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T23:49:52.136673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.815522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-02T23:49:52.136735Z","caller":"traceutil/trace.go:171","msg":"trace[461432508] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:495; }","duration":"413.946725ms","start":"2026-02-02T23:49:51.722773Z","end":"2026-02-02T23:49:52.136719Z","steps":["trace[461432508] 'agreement among raft nodes before linearized reading' (duration: 259.889604ms)","trace[461432508] 'range keys from in-memory index tree' (duration: 153.892638ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:49:52.136772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:51.722754Z","time spent":"414.006516ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-02T23:49:52.136758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.050482ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-02T23:49:52.136922Z","caller":"traceutil/trace.go:171","msg":"trace[1845691910] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"147.611994ms","start":"2026-02-02T23:49:51.989278Z","end":"2026-02-02T23:49:52.13689Z","steps":["trace[1845691910] 'process raft request' (duration: 147.562173ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:49:52.13708Z","caller":"traceutil/trace.go:171","msg":"trace[1599783672] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"149.294832ms","start":"2026-02-02T23:49:51.987776Z","end":"2026-02-02T23:49:52.137071Z","steps":["trace[1599783672] 'process raft request' (duration: 26.849361ms)","trace[1599783672] 'compare' (duration: 121.94044ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:49:53.741944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.526766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-02T23:49:53.741998Z","caller":"traceutil/trace.go:171","msg":"trace[697004976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:506; }","duration":"141.629329ms","start":"2026-02-02T23:49:53.600357Z","end":"2026-02-02T23:49:53.741986Z","steps":["trace[697004976] 'range keys from in-memory index tree' (duration: 141.451904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:49:54.967797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.489201ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-02T23:49:54.968063Z","caller":"traceutil/trace.go:171","msg":"trace[1277707559] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"336.54354ms","start":"2026-02-02T23:49:54.631433Z","end":"2026-02-02T23:49:54.967977Z","steps":["trace[1277707559] 'process raft request' (duration: 177.829554ms)","trace[1277707559] 'compare' (duration: 158.224725ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:49:54.968588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:49:54.631415Z","time spent":"336.854278ms","remote":"127.0.0.1:43154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-02T23:50:19.450693Z","caller":"traceutil/trace.go:171","msg":"trace[1067581373] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"238.746602ms","start":"2026-02-02T23:50:19.211932Z","end":"2026-02-02T23:50:19.450679Z","steps":["trace[1067581373] 'process raft request' (duration: 238.470126ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:20.417176Z","caller":"traceutil/trace.go:171","msg":"trace[1150704410] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"494.380759ms","start":"2026-02-02T23:50:19.922779Z","end":"2026-02-02T23:50:20.41716Z","steps":["trace[1150704410] 'process raft request' (duration: 494.236165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:20.417289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:50:19.922744Z","time spent":"494.487771ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T23:50:20.418658Z","caller":"traceutil/trace.go:171","msg":"trace[1227069899] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:730; }","duration":"118.857209ms","start":"2026-02-02T23:50:20.299783Z","end":"2026-02-02T23:50:20.41864Z","steps":["trace[1227069899] 'read index received' (duration: 117.277123ms)","trace[1227069899] 'applied index is now lower than readState.Index' (duration: 1.579436ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:50:20.418778Z","caller":"traceutil/trace.go:171","msg":"trace[95987215] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"179.264366ms","start":"2026-02-02T23:50:20.239506Z","end":"2026-02-02T23:50:20.41877Z","steps":["trace[95987215] 'process raft request' (duration: 179.066332ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:20.418923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.140955ms","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-02T23:50:20.418957Z","caller":"traceutil/trace.go:171","msg":"trace[920399591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:710; }","duration":"119.219317ms","start":"2026-02-02T23:50:20.299729Z","end":"2026-02-02T23:50:20.418949Z","steps":["trace[920399591] 'agreement among raft nodes before linearized reading' (duration: 119.118195ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:26.884482Z","caller":"traceutil/trace.go:171","msg":"trace[444269718] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"449.404383ms","start":"2026-02-02T23:50:26.435051Z","end":"2026-02-02T23:50:26.884455Z","steps":["trace[444269718] 'process raft request' (duration: 449.221119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:26.884648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:50:26.435012Z","time spent":"449.554776ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T23:50:26.886141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.546225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-02T23:50:26.886185Z","caller":"traceutil/trace.go:171","msg":"trace[604841066] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:726; }","duration":"445.594336ms","start":"2026-02-02T23:50:26.44058Z","end":"2026-02-02T23:50:26.886174Z","steps":["trace[604841066] 'agreement among raft nodes before linearized reading' (duration: 445.465043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:26.886222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:50:26.440565Z","time spent":"445.649788ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-02T23:50:26.886Z","caller":"traceutil/trace.go:171","msg":"trace[707383029] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:749; }","duration":"444.601603ms","start":"2026-02-02T23:50:26.440582Z","end":"2026-02-02T23:50:26.885184Z","steps":["trace[707383029] 'read index received' (duration: 444.597093ms)","trace[707383029] 'applied index is now lower than readState.Index' (duration: 3.49µs)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:50:26.886682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.789855ms","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-02T23:50:26.886714Z","caller":"traceutil/trace.go:171","msg":"trace[1473042593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:726; }","duration":"436.830606ms","start":"2026-02-02T23:50:26.449873Z","end":"2026-02-02T23:50:26.886704Z","steps":["trace[1473042593] 'agreement among raft nodes before linearized reading' (duration: 436.743794ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:26.88674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:50:26.449869Z","time spent":"436.865918ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-02T23:50:26.887006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.634257ms","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-02T23:50:26.887059Z","caller":"traceutil/trace.go:171","msg":"trace[1447248941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:726; }","duration":"434.738069ms","start":"2026-02-02T23:50:26.452304Z","end":"2026-02-02T23:50:26.887042Z","steps":["trace[1447248941] 'agreement among raft nodes before linearized reading' (duration: 434.532954ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:26.887088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:50:26.452296Z","time spent":"434.78726ms","remote":"127.0.0.1:43324","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":"info","ts":"2026-02-02T23:50:27.010631Z","caller":"traceutil/trace.go:171","msg":"trace[1704576998] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"117.208852ms","start":"2026-02-02T23:50:26.893409Z","end":"2026-02-02T23:50:27.010617Z","steps":["trace[1704576998] 'process raft request' (duration: 117.185181ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:27.010824Z","caller":"traceutil/trace.go:171","msg":"trace[691186109] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"121.004148ms","start":"2026-02-02T23:50:26.889814Z","end":"2026-02-02T23:50:27.010818Z","steps":["trace[691186109] 'process raft request' (duration: 54.896451ms)","trace[691186109] 'compare' (duration: 65.80221ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:50:27.010883Z","caller":"traceutil/trace.go:171","msg":"trace[666476262] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"119.069253ms","start":"2026-02-02T23:50:26.891808Z","end":"2026-02-02T23:50:27.010878Z","steps":["trace[666476262] 'process raft request' (duration: 118.761706ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:27.718979Z","caller":"traceutil/trace.go:171","msg":"trace[517704233] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"117.086399ms","start":"2026-02-02T23:50:27.601875Z","end":"2026-02-02T23:50:27.718961Z","steps":["trace[517704233] 'process raft request' (duration: 116.986267ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:38.150148Z","caller":"traceutil/trace.go:171","msg":"trace[638653222] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"143.751375ms","start":"2026-02-02T23:50:38.006383Z","end":"2026-02-02T23:50:38.150135Z","steps":["trace[638653222] 'process raft request' (duration: 143.643833ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:39.453289Z","caller":"traceutil/trace.go:171","msg":"trace[1049234261] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"378.567268ms","start":"2026-02-02T23:50:39.074708Z","end":"2026-02-02T23:50:39.453275Z","steps":["trace[1049234261] 'read index received' (duration: 378.447115ms)","trace[1049234261] 'applied index is now lower than readState.Index' (duration: 119.673µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:50:39.453427Z","caller":"traceutil/trace.go:171","msg":"trace[998709242] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"498.404566ms","start":"2026-02-02T23:50:38.955017Z","end":"2026-02-02T23:50:39.453422Z","steps":["trace[998709242] 'process raft request' (duration: 498.17041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:39.453485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:50:38.955002Z","time spent":"498.438916ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T23:50:39.453613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.905176ms","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-02T23:50:39.453628Z","caller":"traceutil/trace.go:171","msg":"trace[294542468] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:761; }","duration":"378.938387ms","start":"2026-02-02T23:50:39.074685Z","end":"2026-02-02T23:50:39.453624Z","steps":["trace[294542468] 'agreement among raft nodes before linearized reading' (duration: 378.882046ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:39.453641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:50:39.074676Z","time spent":"378.962758ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-02T23:50:39.453719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.188708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-02T23:50:39.453732Z","caller":"traceutil/trace.go:171","msg":"trace[978778756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:761; }","duration":"357.211949ms","start":"2026-02-02T23:50:39.096515Z","end":"2026-02-02T23:50:39.453727Z","steps":["trace[978778756] 'agreement among raft nodes before linearized reading' (duration: 357.179008ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:39.453745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:50:39.096509Z","time spent":"357.233839ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-02T23:50:39.453906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.328272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-02T23:50:39.453922Z","caller":"traceutil/trace.go:171","msg":"trace[1492882135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:761; }","duration":"357.351972ms","start":"2026-02-02T23:50:39.096566Z","end":"2026-02-02T23:50:39.453918Z","steps":["trace[1492882135] 'agreement among raft nodes before linearized reading' (duration: 357.314551ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:39.453933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:50:39.096563Z","time spent":"357.367582ms","remote":"127.0.0.1:43324","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-02T23:50:39.672574Z","caller":"traceutil/trace.go:171","msg":"trace[2010695153] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"215.593872ms","start":"2026-02-02T23:50:39.456956Z","end":"2026-02-02T23:50:39.67255Z","steps":["trace[2010695153] 'process raft request' (duration: 215.365867ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:39.717411Z","caller":"traceutil/trace.go:171","msg":"trace[101526794] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:787; }","duration":"174.93388ms","start":"2026-02-02T23:50:39.542452Z","end":"2026-02-02T23:50:39.717386Z","steps":["trace[101526794] 'read index received' (duration: 129.865877ms)","trace[101526794] 'applied index is now lower than readState.Index' (duration: 45.067383ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:50:39.717468Z","caller":"traceutil/trace.go:171","msg":"trace[1061652920] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"259.311774ms","start":"2026-02-02T23:50:39.458126Z","end":"2026-02-02T23:50:39.717438Z","steps":["trace[1061652920] 'process raft request' (duration: 259.14817ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:39.717506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.047083ms","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-02T23:50:39.717524Z","caller":"traceutil/trace.go:171","msg":"trace[345905469] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:764; }","duration":"175.112735ms","start":"2026-02-02T23:50:39.542405Z","end":"2026-02-02T23:50:39.717518Z","steps":["trace[345905469] 'agreement among raft nodes before linearized reading' (duration: 175.034673ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:39.717643Z","caller":"traceutil/trace.go:171","msg":"trace[115687575] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"257.038442ms","start":"2026-02-02T23:50:39.460599Z","end":"2026-02-02T23:50:39.717638Z","steps":["trace[115687575] 'process raft request' (duration: 256.770886ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:39.876462Z","caller":"traceutil/trace.go:171","msg":"trace[1557559074] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"155.535196ms","start":"2026-02-02T23:50:39.720907Z","end":"2026-02-02T23:50:39.876442Z","steps":["trace[1557559074] 'process raft request' (duration: 80.466575ms)","trace[1557559074] 'compare' (duration: 74.948628ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:50:40.654203Z","caller":"traceutil/trace.go:171","msg":"trace[873247378] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"102.205773ms","start":"2026-02-02T23:50:40.551979Z","end":"2026-02-02T23:50:40.654185Z","steps":["trace[873247378] 'process raft request' (duration: 102.10735ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:41.651783Z","caller":"traceutil/trace.go:171","msg":"trace[1335703538] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"188.882711ms","start":"2026-02-02T23:50:41.462881Z","end":"2026-02-02T23:50:41.651763Z","steps":["trace[1335703538] 'process raft request' (duration: 188.774748ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:41.923553Z","caller":"traceutil/trace.go:171","msg":"trace[1989632429] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:793; }","duration":"202.384059ms","start":"2026-02-02T23:50:41.72115Z","end":"2026-02-02T23:50:41.923534Z","steps":["trace[1989632429] 'read index received' (duration: 202.234406ms)","trace[1989632429] 'applied index is now lower than readState.Index' (duration: 148.803µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:50:41.923811Z","caller":"traceutil/trace.go:171","msg":"trace[1303061198] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"241.153498ms","start":"2026-02-02T23:50:41.682647Z","end":"2026-02-02T23:50:41.923801Z","steps":["trace[1303061198] 'process raft request' (duration: 240.78727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:41.924063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.896621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-02T23:50:41.924106Z","caller":"traceutil/trace.go:171","msg":"trace[947444148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:768; }","duration":"202.982743ms","start":"2026-02-02T23:50:41.721111Z","end":"2026-02-02T23:50:41.924094Z","steps":["trace[947444148] 'agreement among raft nodes before linearized reading' (duration: 202.86371ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:41.924347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.028641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-02T23:50:41.924382Z","caller":"traceutil/trace.go:171","msg":"trace[136479814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:768; }","duration":"202.083362ms","start":"2026-02-02T23:50:41.722289Z","end":"2026-02-02T23:50:41.924373Z","steps":["trace[136479814] 'agreement among raft nodes before linearized reading' (duration: 201.999881ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:53.914338Z","caller":"traceutil/trace.go:171","msg":"trace[961826237] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"218.227052ms","start":"2026-02-02T23:50:53.695931Z","end":"2026-02-02T23:50:53.914158Z","steps":["trace[961826237] 'process raft request' (duration: 218.12253ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:54.268555Z","caller":"traceutil/trace.go:171","msg":"trace[247864877] linearizableReadLoop","detail":"{readStateIndex:885; appliedIndex:883; }","duration":"163.950698ms","start":"2026-02-02T23:50:54.104598Z","end":"2026-02-02T23:50:54.268549Z","steps":["trace[247864877] 'read index received' (duration: 162.819082ms)","trace[247864877] 'applied index is now lower than readState.Index' (duration: 1.131236ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:50:54.268742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.124511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-02T23:50:54.268765Z","caller":"traceutil/trace.go:171","msg":"trace[555617083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:854; }","duration":"164.196623ms","start":"2026-02-02T23:50:54.104562Z","end":"2026-02-02T23:50:54.268759Z","steps":["trace[555617083] 'agreement among raft nodes before linearized reading' (duration: 164.0378ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:54.268926Z","caller":"traceutil/trace.go:171","msg":"trace[2046312809] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"183.484056ms","start":"2026-02-02T23:50:54.085436Z","end":"2026-02-02T23:50:54.26892Z","steps":["trace[2046312809] 'process raft request' (duration: 183.080377ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:54.268467Z","caller":"traceutil/trace.go:171","msg":"trace[102528595] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"182.499583ms","start":"2026-02-02T23:50:54.085011Z","end":"2026-02-02T23:50:54.267511Z","steps":["trace[102528595] 'process raft request' (duration: 182.35506ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:50:56.068467Z","caller":"traceutil/trace.go:171","msg":"trace[216981326] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"148.76457ms","start":"2026-02-02T23:50:55.919634Z","end":"2026-02-02T23:50:56.068399Z","steps":["trace[216981326] 'process raft request' (duration: 148.435103ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:56.443092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.364784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-02T23:50:56.443163Z","caller":"traceutil/trace.go:171","msg":"trace[1965292384] linearizableReadLoop","detail":"{readStateIndex:888; appliedIndex:887; }","duration":"171.403909ms","start":"2026-02-02T23:50:56.27175Z","end":"2026-02-02T23:50:56.443154Z","steps":["trace[1965292384] 'read index received' (duration: 17.891µs)","trace[1965292384] 'applied index is now lower than readState.Index' (duration: 171.385378ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:50:56.443269Z","caller":"traceutil/trace.go:171","msg":"trace[374810404] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"372.821127ms","start":"2026-02-02T23:50:56.070442Z","end":"2026-02-02T23:50:56.443263Z","steps":["trace[374810404] 'process raft request' (duration: 141.238838ms)","trace[374810404] 'compare' (duration: 231.137949ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:50:56.443297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:50:56.070432Z","time spent":"372.851247ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T23:50:56.443422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.670685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-02T23:50:56.443436Z","caller":"traceutil/trace.go:171","msg":"trace[890586549] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:857; }","duration":"171.706416ms","start":"2026-02-02T23:50:56.271725Z","end":"2026-02-02T23:50:56.443431Z","steps":["trace[890586549] 'agreement among raft nodes before linearized reading' (duration: 171.648364ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:56.443516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.610344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-02T23:50:56.443528Z","caller":"traceutil/trace.go:171","msg":"trace[634479348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:857; }","duration":"171.629924ms","start":"2026-02-02T23:50:56.271894Z","end":"2026-02-02T23:50:56.443524Z","steps":["trace[634479348] 'agreement among raft nodes before linearized reading' (duration: 171.595933ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:50:56.443681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.012634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-02T23:50:56.443693Z","caller":"traceutil/trace.go:171","msg":"trace[1932973043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:857; }","duration":"169.046046ms","start":"2026-02-02T23:50:56.274643Z","end":"2026-02-02T23:50:56.443689Z","steps":["trace[1932973043] 'agreement among raft nodes before linearized reading' (duration: 169.012345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:00.776201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.063756ms","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-02T23:51:00.776274Z","caller":"traceutil/trace.go:171","msg":"trace[507790309] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:868; }","duration":"470.160319ms","start":"2026-02-02T23:51:00.306103Z","end":"2026-02-02T23:51:00.776263Z","steps":["trace[507790309] 'range keys from in-memory index tree' (duration: 470.052666ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:00.776436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.778171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T23:51:00.776455Z","caller":"traceutil/trace.go:171","msg":"trace[455750315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:868; }","duration":"415.818243ms","start":"2026-02-02T23:51:00.360631Z","end":"2026-02-02T23:51:00.776449Z","steps":["trace[455750315] 'range keys from in-memory index tree' (duration: 415.70971ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:00.776471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:00.360618Z","time spent":"415.848403ms","remote":"127.0.0.1:43076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-02T23:51:00.776679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.715853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-02T23:51:00.776696Z","caller":"traceutil/trace.go:171","msg":"trace[2011235932] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:868; }","duration":"320.756033ms","start":"2026-02-02T23:51:00.455936Z","end":"2026-02-02T23:51:00.776692Z","steps":["trace[2011235932] 'range keys from in-memory index tree' (duration: 320.627671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:00.776709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:00.455924Z","time spent":"320.781585ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-02T23:51:00.776848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.247592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T23:51:00.776868Z","caller":"traceutil/trace.go:171","msg":"trace[1120003202] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:868; }","duration":"262.274973ms","start":"2026-02-02T23:51:00.514586Z","end":"2026-02-02T23:51:00.776861Z","steps":["trace[1120003202] 'count revisions from in-memory index tree' (duration: 262.223512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:00.776952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.359095ms","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-02T23:51:00.776964Z","caller":"traceutil/trace.go:171","msg":"trace[1902137970] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:868; }","duration":"252.381675ms","start":"2026-02-02T23:51:00.524579Z","end":"2026-02-02T23:51:00.77696Z","steps":["trace[1902137970] 'range keys from in-memory index tree' (duration: 252.320935ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:00.777045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.846416ms","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-02T23:51:00.777056Z","caller":"traceutil/trace.go:171","msg":"trace[1114202195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:868; }","duration":"245.866577ms","start":"2026-02-02T23:51:00.531186Z","end":"2026-02-02T23:51:00.777053Z","steps":["trace[1114202195] 'range keys from in-memory index tree' (duration: 245.809996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:00.777132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.604678ms","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-02T23:51:00.777146Z","caller":"traceutil/trace.go:171","msg":"trace[1073328194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:868; }","duration":"241.667341ms","start":"2026-02-02T23:51:00.535475Z","end":"2026-02-02T23:51:00.777143Z","steps":["trace[1073328194] 'range keys from in-memory index tree' (duration: 241.511307ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:51:05.028457Z","caller":"traceutil/trace.go:171","msg":"trace[650281386] linearizableReadLoop","detail":"{readStateIndex:913; appliedIndex:912; }","duration":"228.345855ms","start":"2026-02-02T23:51:04.800076Z","end":"2026-02-02T23:51:05.028422Z","steps":["trace[650281386] 'read index received' (duration: 228.190761ms)","trace[650281386] 'applied index is now lower than readState.Index' (duration: 154.404µs)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:51:05.028945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.565296ms","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-02T23:51:05.029007Z","caller":"traceutil/trace.go:171","msg":"trace[637155833] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:880; }","duration":"227.647549ms","start":"2026-02-02T23:51:04.801346Z","end":"2026-02-02T23:51:05.028994Z","steps":["trace[637155833] 'agreement among raft nodes before linearized reading' (duration: 227.437214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:05.02922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.119392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-02T23:51:05.029253Z","caller":"traceutil/trace.go:171","msg":"trace[1006145559] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:880; }","duration":"229.178273ms","start":"2026-02-02T23:51:04.800065Z","end":"2026-02-02T23:51:05.029243Z","steps":["trace[1006145559] 'agreement among raft nodes before linearized reading' (duration: 229.062831ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:05.029392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.758379ms","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-02T23:51:05.029413Z","caller":"traceutil/trace.go:171","msg":"trace[258307069] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:880; }","duration":"192.81683ms","start":"2026-02-02T23:51:04.83659Z","end":"2026-02-02T23:51:05.029407Z","steps":["trace[258307069] 'agreement among raft nodes before linearized reading' (duration: 192.758309ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:51:05.029817Z","caller":"traceutil/trace.go:171","msg":"trace[1841542728] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"236.141053ms","start":"2026-02-02T23:51:04.793664Z","end":"2026-02-02T23:51:05.029805Z","steps":["trace[1841542728] 'process raft request' (duration: 234.645319ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:05.624998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.19353ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-02T23:51:05.625056Z","caller":"traceutil/trace.go:171","msg":"trace[212017755] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"585.917122ms","start":"2026-02-02T23:51:05.039129Z","end":"2026-02-02T23:51:05.625046Z","steps":["trace[212017755] 'process raft request' (duration: 296.6285ms)","trace[212017755] 'compare' (duration: 289.097767ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:51:05.625114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:05.039111Z","time spent":"585.961302ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T23:51:05.662427Z","caller":"traceutil/trace.go:171","msg":"trace[420746747] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:913; }","duration":"333.406643ms","start":"2026-02-02T23:51:05.329009Z","end":"2026-02-02T23:51:05.662416Z","steps":["trace[420746747] 'read index received' (duration: 6.754695ms)","trace[420746747] 'applied index is now lower than readState.Index' (duration: 326.651418ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:51:05.662609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.613998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-02T23:51:05.662646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.31358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T23:51:05.66266Z","caller":"traceutil/trace.go:171","msg":"trace[1375544689] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:883; }","duration":"333.68276ms","start":"2026-02-02T23:51:05.328965Z","end":"2026-02-02T23:51:05.662648Z","steps":["trace[1375544689] 'agreement among raft nodes before linearized reading' (duration: 333.544496ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:51:05.662667Z","caller":"traceutil/trace.go:171","msg":"trace[742365813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:883; }","duration":"302.366171ms","start":"2026-02-02T23:51:05.360295Z","end":"2026-02-02T23:51:05.662661Z","steps":["trace[742365813] 'agreement among raft nodes before linearized reading' (duration: 302.32973ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:05.662688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:05.328947Z","time spent":"333.7364ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-02-02T23:51:05.6627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:05.360288Z","time spent":"302.407982ms","remote":"127.0.0.1:43076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-02T23:51:05.662843Z","caller":"traceutil/trace.go:171","msg":"trace[912862384] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"620.265229ms","start":"2026-02-02T23:51:05.042571Z","end":"2026-02-02T23:51:05.662836Z","steps":["trace[912862384] 'process raft request' (duration: 619.756707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:05.662894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:05.042556Z","time spent":"620.301059ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T23:51:05.66291Z","caller":"traceutil/trace.go:171","msg":"trace[1797244142] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"612.674085ms","start":"2026-02-02T23:51:05.050228Z","end":"2026-02-02T23:51:05.662902Z","steps":["trace[1797244142] 'process raft request' (duration: 612.169273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:05.663964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:05.050219Z","time spent":"613.715199ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T23:51:07.225995Z","caller":"traceutil/trace.go:171","msg":"trace[500626332] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"179.951925ms","start":"2026-02-02T23:51:07.04602Z","end":"2026-02-02T23:51:07.225972Z","steps":["trace[500626332] 'process raft request' (duration: 179.776441ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:51:12.111815Z","caller":"traceutil/trace.go:171","msg":"trace[435624285] linearizableReadLoop","detail":"{readStateIndex:933; appliedIndex:932; }","duration":"432.332771ms","start":"2026-02-02T23:51:11.679461Z","end":"2026-02-02T23:51:12.111793Z","steps":["trace[435624285] 'read index received' (duration: 432.050274ms)","trace[435624285] 'applied index is now lower than readState.Index' (duration: 281.187µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:51:12.111983Z","caller":"traceutil/trace.go:171","msg":"trace[1630756549] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"463.410303ms","start":"2026-02-02T23:51:11.648562Z","end":"2026-02-02T23:51:12.111972Z","steps":["trace[1630756549] 'process raft request' (duration: 462.976663ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:12.112156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:11.648548Z","time spent":"463.473905ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T23:51:12.112162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.574808ms","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-02T23:51:12.112363Z","caller":"traceutil/trace.go:171","msg":"trace[1363973485] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:899; }","duration":"429.797592ms","start":"2026-02-02T23:51:11.68255Z","end":"2026-02-02T23:51:12.112348Z","steps":["trace[1363973485] 'agreement among raft nodes before linearized reading' (duration: 429.498276ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:12.112395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:11.682544Z","time spent":"429.844163ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-02T23:51:12.112523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.067537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-02T23:51:12.112537Z","caller":"traceutil/trace.go:171","msg":"trace[789311187] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:899; }","duration":"433.109799ms","start":"2026-02-02T23:51:11.679422Z","end":"2026-02-02T23:51:12.112532Z","steps":["trace[789311187] 'agreement among raft nodes before linearized reading' (duration: 433.068768ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:12.112549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:11.679407Z","time spent":"433.139579ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-02T23:51:12.112742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.548765ms","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-02T23:51:12.112757Z","caller":"traceutil/trace.go:171","msg":"trace[1650916543] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:899; }","duration":"230.606467ms","start":"2026-02-02T23:51:11.882146Z","end":"2026-02-02T23:51:12.112752Z","steps":["trace[1650916543] 'agreement among raft nodes before linearized reading' (duration: 230.578526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:13.540922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.951496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T23:51:13.540986Z","caller":"traceutil/trace.go:171","msg":"trace[594156098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:903; }","duration":"180.046357ms","start":"2026-02-02T23:51:13.360927Z","end":"2026-02-02T23:51:13.540973Z","steps":["trace[594156098] 'range keys from in-memory index tree' (duration: 179.904315ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:51:14.738644Z","caller":"traceutil/trace.go:171","msg":"trace[910950835] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"525.658779ms","start":"2026-02-02T23:51:14.212963Z","end":"2026-02-02T23:51:14.738622Z","steps":["trace[910950835] 'process raft request' (duration: 482.444969ms)","trace[910950835] 'compare' (duration: 42.722609ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:51:14.738749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:14.212942Z","time spent":"525.749801ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T23:51:14.759654Z","caller":"traceutil/trace.go:171","msg":"trace[1377071870] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:939; }","duration":"396.073149ms","start":"2026-02-02T23:51:14.363565Z","end":"2026-02-02T23:51:14.759639Z","steps":["trace[1377071870] 'read index received' (duration: 331.774305ms)","trace[1377071870] 'applied index is now lower than readState.Index' (duration: 64.298004ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:51:14.75987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.428504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T23:51:14.759894Z","caller":"traceutil/trace.go:171","msg":"trace[753562408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:907; }","duration":"395.513306ms","start":"2026-02-02T23:51:14.364374Z","end":"2026-02-02T23:51:14.759887Z","steps":["trace[753562408] 'agreement among raft nodes before linearized reading' (duration: 395.464635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:14.759915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:14.364347Z","time spent":"395.563497ms","remote":"127.0.0.1:43076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-02T23:51:14.759969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.353725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T23:51:14.760058Z","caller":"traceutil/trace.go:171","msg":"trace[1521997189] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:907; }","duration":"396.531409ms","start":"2026-02-02T23:51:14.363507Z","end":"2026-02-02T23:51:14.760038Z","steps":["trace[1521997189] 'agreement among raft nodes before linearized reading' (duration: 396.318924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:14.760102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:14.363359Z","time spent":"396.735574ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-02-02T23:51:14.760144Z","caller":"traceutil/trace.go:171","msg":"trace[1980974134] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"546.895136ms","start":"2026-02-02T23:51:14.213239Z","end":"2026-02-02T23:51:14.760134Z","steps":["trace[1980974134] 'process raft request' (duration: 546.304583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:14.760296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:14.213229Z","time spent":"546.934497ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T23:51:14.760453Z","caller":"traceutil/trace.go:171","msg":"trace[327886442] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"544.674065ms","start":"2026-02-02T23:51:14.215759Z","end":"2026-02-02T23:51:14.760433Z","steps":["trace[327886442] 'process raft request' (duration: 543.853706ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:14.760496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:14.215737Z","time spent":"544.736496ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T23:51:15.125257Z","caller":"traceutil/trace.go:171","msg":"trace[1821221183] linearizableReadLoop","detail":"{readStateIndex:943; appliedIndex:942; }","duration":"177.405927ms","start":"2026-02-02T23:51:14.947803Z","end":"2026-02-02T23:51:15.125208Z","steps":["trace[1821221183] 'read index received' (duration: 146.681583ms)","trace[1821221183] 'applied index is now lower than readState.Index' (duration: 30.723324ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:51:15.125422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.590392ms","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-02T23:51:15.12545Z","caller":"traceutil/trace.go:171","msg":"trace[863848889] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:908; }","duration":"177.684354ms","start":"2026-02-02T23:51:14.947759Z","end":"2026-02-02T23:51:15.125443Z","steps":["trace[863848889] 'agreement among raft nodes before linearized reading' (duration: 177.559361ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:51:15.125591Z","caller":"traceutil/trace.go:171","msg":"trace[469731433] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"289.002355ms","start":"2026-02-02T23:51:14.836581Z","end":"2026-02-02T23:51:15.125583Z","steps":["trace[469731433] 'process raft request' (duration: 257.944273ms)","trace[469731433] 'compare' (duration: 30.569781ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T23:51:15.640738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.320476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-02T23:51:15.640823Z","caller":"traceutil/trace.go:171","msg":"trace[1879906748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:908; }","duration":"379.477749ms","start":"2026-02-02T23:51:15.261326Z","end":"2026-02-02T23:51:15.640804Z","steps":["trace[1879906748] 'range keys from in-memory index tree' (duration: 379.06501ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:15.640879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:15.261282Z","time spent":"379.581261ms","remote":"127.0.0.1:43324","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-02T23:51:20.250739Z","caller":"traceutil/trace.go:171","msg":"trace[482806109] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"511.475805ms","start":"2026-02-02T23:51:19.671332Z","end":"2026-02-02T23:51:20.182808Z","steps":["trace[482806109] 'process raft request' (duration: 511.389653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:20.250989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T23:51:19.671323Z","time spent":"579.599387ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T23:51:26.929732Z","caller":"traceutil/trace.go:171","msg":"trace[421243170] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1017; }","duration":"116.400289ms","start":"2026-02-02T23:51:26.813314Z","end":"2026-02-02T23:51:26.929715Z","steps":["trace[421243170] 'read index received' (duration: 116.292496ms)","trace[421243170] 'applied index is now lower than readState.Index' (duration: 107.083µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:51:26.929828Z","caller":"traceutil/trace.go:171","msg":"trace[2111230825] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"150.605332ms","start":"2026-02-02T23:51:26.779213Z","end":"2026-02-02T23:51:26.929818Z","steps":["trace[2111230825] 'process raft request' (duration: 150.392837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:26.930184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.855539ms","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-02T23:51:26.93021Z","caller":"traceutil/trace.go:171","msg":"trace[550017266] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:981; }","duration":"116.91328ms","start":"2026-02-02T23:51:26.813289Z","end":"2026-02-02T23:51:26.930202Z","steps":["trace[550017266] 'agreement among raft nodes before linearized reading' (duration: 116.811328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:51:26.932325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.934056ms","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-02T23:51:26.932373Z","caller":"traceutil/trace.go:171","msg":"trace[917142996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:981; }","duration":"118.996588ms","start":"2026-02-02T23:51:26.813367Z","end":"2026-02-02T23:51:26.932363Z","steps":["trace[917142996] 'agreement among raft nodes before linearized reading' (duration: 116.571523ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T23:54:35.661134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.984551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-02T23:54:35.661184Z","caller":"traceutil/trace.go:171","msg":"trace[2042573640] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1801; }","duration":"187.070103ms","start":"2026-02-02T23:54:35.474105Z","end":"2026-02-02T23:54:35.661175Z","steps":["trace[2042573640] 'agreement among raft nodes before linearized reading' (duration: 186.920789ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T23:54:35.647097Z","caller":"traceutil/trace.go:171","msg":"trace[976269284] linearizableReadLoop","detail":"{readStateIndex:1877; appliedIndex:1876; }","duration":"172.937971ms","start":"2026-02-02T23:54:35.474137Z","end":"2026-02-02T23:54:35.647075Z","steps":["trace[976269284] 'read index received' (duration: 89.648878ms)","trace[976269284] 'applied index is now lower than readState.Index' (duration: 83.288333ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T23:54:35.647202Z","caller":"traceutil/trace.go:171","msg":"trace[1105168687] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"222.741208ms","start":"2026-02-02T23:54:35.424443Z","end":"2026-02-02T23:54:35.647184Z","steps":["trace[1105168687] 'process raft request' (duration: 139.311402ms)","trace[1105168687] 'compare' (duration: 83.248092ms)"],"step_count":2}