{"level":"warn","ts":"2026-02-12T03:39:27.571697Z","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-12T03:39:27.571793Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-12T03:39:27.571967Z","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-12T03:39:27.571983Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-02-12T03:39:27.57206Z","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-12T03:39:27.57275Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-02-12T03:39:27.572895Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-12T03:39:27.580133Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.947042ms"} {"level":"info","ts":"2026-02-12T03:39:27.593976Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-02-12T03:39:27.59409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-02-12T03:39:27.594111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-02-12T03:39:27.594119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-12T03:39:27.594184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-02-12T03:39:27.594247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-02-12T03:39:27.599909Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-12T03:39:27.626185Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-12T03:39:27.642067Z","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-12T03:39:27.648077Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-12T03:39:27.651738Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-12T03:39:27.651899Z","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-12T03:39:27.651932Z","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-12T03:39:27.651939Z","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-12T03:39:27.652166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-02-12T03:39:27.652257Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-02-12T03:39:27.672613Z","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-12T03:39:27.672827Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-12T03:39:27.672873Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-12T03:39:27.673402Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-02-12T03:39:27.673445Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-02-12T03:39:28.595441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-02-12T03:39:28.595487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-02-12T03:39:28.595508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-02-12T03:39:28.59552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-02-12T03:39:28.595525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-02-12T03:39:28.595533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-02-12T03:39:28.595541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-02-12T03:39:28.597666Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-02-12T03:39:28.597778Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T03:39:28.598308Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:39:28.598539Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T03:39:28.603849Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-12T03:39:28.607025Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:39:28.607186Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:39:28.607266Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:39:28.620973Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-02-12T03:39:28.627404Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-12T03:39:28.627487Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-12T03:39:36.526686Z","caller":"traceutil/trace.go:171","msg":"trace[1041168188] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"134.493097ms","start":"2026-02-12T03:39:36.392175Z","end":"2026-02-12T03:39:36.526668Z","steps":["trace[1041168188] 'process raft request' (duration: 134.364523ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:39.091778Z","caller":"traceutil/trace.go:171","msg":"trace[1125624156] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:351; }","duration":"118.523351ms","start":"2026-02-12T03:39:38.973237Z","end":"2026-02-12T03:39:39.09176Z","steps":["trace[1125624156] 'read index received' (duration: 115.334767ms)","trace[1125624156] 'applied index is now lower than readState.Index' (duration: 3.188014ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:39.0919Z","caller":"traceutil/trace.go:171","msg":"trace[655011422] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"118.918272ms","start":"2026-02-12T03:39:38.972975Z","end":"2026-02-12T03:39:39.091893Z","steps":["trace[655011422] 'process raft request' (duration: 115.599705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:39.092111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.861071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-02-12T03:39:39.092134Z","caller":"traceutil/trace.go:171","msg":"trace[1924292022] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:341; }","duration":"118.949243ms","start":"2026-02-12T03:39:38.973178Z","end":"2026-02-12T03:39:39.092127Z","steps":["trace[1924292022] 'agreement among raft nodes before linearized reading' (duration: 118.871281ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:39.092259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.056715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-12T03:39:39.092279Z","caller":"traceutil/trace.go:171","msg":"trace[1124317942] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:341; }","duration":"100.104186ms","start":"2026-02-12T03:39:38.992169Z","end":"2026-02-12T03:39:39.092273Z","steps":["trace[1124317942] 'agreement among raft nodes before linearized reading' (duration: 100.063625ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:45.9545Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605826620566269293,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-12T03:39:46.273989Z","caller":"traceutil/trace.go:171","msg":"trace[676787492] linearizableReadLoop","detail":"{readStateIndex:393; appliedIndex:392; }","duration":"819.915152ms","start":"2026-02-12T03:39:45.454051Z","end":"2026-02-12T03:39:46.273966Z","steps":["trace[676787492] 'read index received' (duration: 819.723328ms)","trace[676787492] 'applied index is now lower than readState.Index' (duration: 189.014µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:46.27432Z","caller":"traceutil/trace.go:171","msg":"trace[119063211] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"936.485953ms","start":"2026-02-12T03:39:45.337823Z","end":"2026-02-12T03:39:46.274309Z","steps":["trace[119063211] 'process raft request' (duration: 936.00814ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.274813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:45.337809Z","time spent":"936.539724ms","remote":"127.0.0.1:38910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:39:46.27505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.994621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:39:46.275083Z","caller":"traceutil/trace.go:171","msg":"trace[862900693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:380; }","duration":"821.052553ms","start":"2026-02-12T03:39:45.45402Z","end":"2026-02-12T03:39:46.275073Z","steps":["trace[862900693] 'agreement among raft nodes before linearized reading' (duration: 820.990111ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.27511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:45.454004Z","time spent":"821.100224ms","remote":"127.0.0.1:40542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-12T03:39:46.275273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.320391ms","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-12T03:39:46.2753Z","caller":"traceutil/trace.go:171","msg":"trace[1842291290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:380; }","duration":"526.400903ms","start":"2026-02-12T03:39:45.748891Z","end":"2026-02-12T03:39:46.275292Z","steps":["trace[1842291290] 'agreement among raft nodes before linearized reading' (duration: 526.352832ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.275324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:45.748868Z","time spent":"526.450574ms","remote":"127.0.0.1:38734","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-12T03:39:46.275582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.483346ms","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-12T03:39:46.275609Z","caller":"traceutil/trace.go:171","msg":"trace[1795888236] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:380; }","duration":"100.523107ms","start":"2026-02-12T03:39:46.175078Z","end":"2026-02-12T03:39:46.275601Z","steps":["trace[1795888236] 'agreement among raft nodes before linearized reading' (duration: 100.471976ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.275729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.114986ms","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-12T03:39:46.275753Z","caller":"traceutil/trace.go:171","msg":"trace[851490191] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:380; }","duration":"103.174858ms","start":"2026-02-12T03:39:46.172571Z","end":"2026-02-12T03:39:46.275746Z","steps":["trace[851490191] 'agreement among raft nodes before linearized reading' (duration: 103.135757ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.275876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.910805ms","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-12T03:39:46.2759Z","caller":"traceutil/trace.go:171","msg":"trace[1009323588] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:380; }","duration":"161.962196ms","start":"2026-02-12T03:39:46.113931Z","end":"2026-02-12T03:39:46.275893Z","steps":["trace[1009323588] 'agreement among raft nodes before linearized reading' (duration: 161.920905ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.734527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.989971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:39:46.734582Z","caller":"traceutil/trace.go:171","msg":"trace[509666442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:380; }","duration":"450.071603ms","start":"2026-02-12T03:39:46.284497Z","end":"2026-02-12T03:39:46.734569Z","steps":["trace[509666442] 'range keys from in-memory index tree' (duration: 449.93665ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.734608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:46.284487Z","time spent":"450.115864ms","remote":"127.0.0.1:40544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-12T03:39:46.734741Z","caller":"traceutil/trace.go:171","msg":"trace[1680019329] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"449.028675ms","start":"2026-02-12T03:39:46.285706Z","end":"2026-02-12T03:39:46.734735Z","steps":["trace[1680019329] 'process raft request' (duration: 447.463704ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.734785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:46.285695Z","time spent":"449.061775ms","remote":"127.0.0.1:38948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3656,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T03:39:46.741134Z","caller":"traceutil/trace.go:171","msg":"trace[2003811515] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"454.196321ms","start":"2026-02-12T03:39:46.286924Z","end":"2026-02-12T03:39:46.741121Z","steps":["trace[2003811515] 'process raft request' (duration: 452.937078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.741245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:46.286916Z","time spent":"454.270142ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:39:46.741686Z","caller":"traceutil/trace.go:171","msg":"trace[1347101657] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"453.345699ms","start":"2026-02-12T03:39:46.288333Z","end":"2026-02-12T03:39:46.741679Z","steps":["trace[1347101657] 'process raft request' (duration: 451.647204ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.741742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:46.288328Z","time spent":"453.3921ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:39:46.741988Z","caller":"traceutil/trace.go:171","msg":"trace[710940959] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"453.586075ms","start":"2026-02-12T03:39:46.288395Z","end":"2026-02-12T03:39:46.741981Z","steps":["trace[710940959] 'process raft request' (duration: 453.089852ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.742025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:46.288392Z","time spent":"453.614186ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:39:46.742917Z","caller":"traceutil/trace.go:171","msg":"trace[2048033752] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"453.941795ms","start":"2026-02-12T03:39:46.288968Z","end":"2026-02-12T03:39:46.742909Z","steps":["trace[2048033752] 'process raft request' (duration: 452.543829ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:46.742956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:46.288962Z","time spent":"453.973506ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:00.930433Z","caller":"traceutil/trace.go:171","msg":"trace[1948259785] linearizableReadLoop","detail":"{readStateIndex:492; appliedIndex:491; }","duration":"124.489978ms","start":"2026-02-12T03:40:00.805917Z","end":"2026-02-12T03:40:00.930407Z","steps":["trace[1948259785] 'read index received' (duration: 124.324514ms)","trace[1948259785] 'applied index is now lower than readState.Index' (duration: 164.854µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:40:00.930516Z","caller":"traceutil/trace.go:171","msg":"trace[556367566] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"197.84944ms","start":"2026-02-12T03:40:00.732661Z","end":"2026-02-12T03:40:00.930511Z","steps":["trace[556367566] 'process raft request' (duration: 197.644045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:00.930681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.755755ms","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-12T03:40:00.930753Z","caller":"traceutil/trace.go:171","msg":"trace[66993832] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:476; }","duration":"124.839917ms","start":"2026-02-12T03:40:00.805908Z","end":"2026-02-12T03:40:00.930748Z","steps":["trace[66993832] 'agreement among raft nodes before linearized reading' (duration: 124.697293ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:00.93084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.802176ms","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-12T03:40:00.930854Z","caller":"traceutil/trace.go:171","msg":"trace[569263883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:476; }","duration":"119.815477ms","start":"2026-02-12T03:40:00.811033Z","end":"2026-02-12T03:40:00.930849Z","steps":["trace[569263883] 'agreement among raft nodes before linearized reading' (duration: 119.759905ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:00.930955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.546854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T03:40:00.930968Z","caller":"traceutil/trace.go:171","msg":"trace[1954673463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:476; }","duration":"112.590615ms","start":"2026-02-12T03:40:00.818374Z","end":"2026-02-12T03:40:00.930965Z","steps":["trace[1954673463] 'agreement among raft nodes before linearized reading' (duration: 112.568335ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:01.423145Z","caller":"traceutil/trace.go:171","msg":"trace[762477598] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"485.009322ms","start":"2026-02-12T03:40:00.938118Z","end":"2026-02-12T03:40:01.423127Z","steps":["trace[762477598] 'process raft request' (duration: 403.27097ms)","trace[762477598] 'compare' (duration: 81.628139ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:40:01.423243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:00.938101Z","time spent":"485.092015ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:01.480362Z","caller":"traceutil/trace.go:171","msg":"trace[454605354] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"537.753222ms","start":"2026-02-12T03:40:00.942594Z","end":"2026-02-12T03:40:01.480347Z","steps":["trace[454605354] 'process raft request' (duration: 537.732471ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:01.480455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:00.942584Z","time spent":"537.821714ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:01.480668Z","caller":"traceutil/trace.go:171","msg":"trace[58630791] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"542.405224ms","start":"2026-02-12T03:40:00.938256Z","end":"2026-02-12T03:40:01.480661Z","steps":["trace[58630791] 'process raft request' (duration: 541.964302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:01.480705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:00.93825Z","time spent":"542.428894ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:01.480762Z","caller":"traceutil/trace.go:171","msg":"trace[1389303178] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"539.891587ms","start":"2026-02-12T03:40:00.940866Z","end":"2026-02-12T03:40:01.480758Z","steps":["trace[1389303178] 'process raft request' (duration: 539.444455ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:01.480785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:00.940858Z","time spent":"539.913818ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:40:03.651757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.452413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-12T03:40:03.651806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.623861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T03:40:03.651808Z","caller":"traceutil/trace.go:171","msg":"trace[1824345493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:482; }","duration":"166.551906ms","start":"2026-02-12T03:40:03.485245Z","end":"2026-02-12T03:40:03.651797Z","steps":["trace[1824345493] 'range keys from in-memory index tree' (duration: 166.377741ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:03.651841Z","caller":"traceutil/trace.go:171","msg":"trace[173962190] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:482; }","duration":"165.673272ms","start":"2026-02-12T03:40:03.486157Z","end":"2026-02-12T03:40:03.65183Z","steps":["trace[173962190] 'range keys from in-memory index tree' (duration: 165.499727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:03.651916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.018642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T03:40:03.651932Z","caller":"traceutil/trace.go:171","msg":"trace[139730212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:482; }","duration":"166.051962ms","start":"2026-02-12T03:40:03.485875Z","end":"2026-02-12T03:40:03.651927Z","steps":["trace[139730212] 'range keys from in-memory index tree' (duration: 165.768826ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:03.759472Z","caller":"traceutil/trace.go:171","msg":"trace[1254469064] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"105.213291ms","start":"2026-02-12T03:40:03.654243Z","end":"2026-02-12T03:40:03.759456Z","steps":["trace[1254469064] 'process raft request' (duration: 105.117709ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:03.774161Z","caller":"traceutil/trace.go:171","msg":"trace[1502590909] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"117.616988ms","start":"2026-02-12T03:40:03.656529Z","end":"2026-02-12T03:40:03.774146Z","steps":["trace[1502590909] 'process raft request' (duration: 117.586547ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:03.774258Z","caller":"traceutil/trace.go:171","msg":"trace[629497311] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"118.615704ms","start":"2026-02-12T03:40:03.655637Z","end":"2026-02-12T03:40:03.774253Z","steps":["trace[629497311] 'process raft request' (duration: 118.405818ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:04.046485Z","caller":"traceutil/trace.go:171","msg":"trace[669031741] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"231.62859ms","start":"2026-02-12T03:40:03.81484Z","end":"2026-02-12T03:40:04.046469Z","steps":["trace[669031741] 'process raft request' (duration: 230.396017ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:09.65507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.607301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:40:09.65515Z","caller":"traceutil/trace.go:171","msg":"trace[1338664274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"195.718844ms","start":"2026-02-12T03:40:09.459411Z","end":"2026-02-12T03:40:09.655129Z","steps":["trace[1338664274] 'range keys from in-memory index tree' (duration: 195.547729ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:09.65532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.713444ms","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-12T03:40:09.655375Z","caller":"traceutil/trace.go:171","msg":"trace[1544535670] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:497; }","duration":"195.785786ms","start":"2026-02-12T03:40:09.459573Z","end":"2026-02-12T03:40:09.655359Z","steps":["trace[1544535670] 'range keys from in-memory index tree' (duration: 195.681902ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:10.240946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.813622ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:40:10.241014Z","caller":"traceutil/trace.go:171","msg":"trace[1224520845] linearizableReadLoop","detail":"{readStateIndex:517; appliedIndex:516; }","duration":"454.564041ms","start":"2026-02-12T03:40:09.786439Z","end":"2026-02-12T03:40:10.241003Z","steps":["trace[1224520845] 'read index received' (duration: 14.44962ms)","trace[1224520845] 'applied index is now lower than readState.Index' (duration: 440.113641ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:40:10.241194Z","caller":"traceutil/trace.go:171","msg":"trace[390901474] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"564.501426ms","start":"2026-02-12T03:40:09.676683Z","end":"2026-02-12T03:40:10.241185Z","steps":["trace[390901474] 'process raft request' (duration: 124.296554ms)","trace[390901474] 'compare' (duration: 439.104164ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:40:10.241241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:09.676647Z","time spent":"564.573477ms","remote":"127.0.0.1:40734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:40:10.241343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.922391ms","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-12T03:40:10.241367Z","caller":"traceutil/trace.go:171","msg":"trace[890000959] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:499; }","duration":"454.970572ms","start":"2026-02-12T03:40:09.78639Z","end":"2026-02-12T03:40:10.24136Z","steps":["trace[890000959] 'agreement among raft nodes before linearized reading' (duration: 454.927929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:10.241387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:09.786374Z","time spent":"455.007753ms","remote":"127.0.0.1:38734","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-12T03:40:10.241482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.24039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T03:40:10.241504Z","caller":"traceutil/trace.go:171","msg":"trace[811557673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:499; }","duration":"438.330843ms","start":"2026-02-12T03:40:09.803168Z","end":"2026-02-12T03:40:10.241499Z","steps":["trace[811557673] 'agreement among raft nodes before linearized reading' (duration: 438.296502ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:10.241521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:09.803148Z","time spent":"438.368924ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-12T03:40:10.241744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.410285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T03:40:10.241771Z","caller":"traceutil/trace.go:171","msg":"trace[1873470680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:499; }","duration":"438.462577ms","start":"2026-02-12T03:40:09.803302Z","end":"2026-02-12T03:40:10.241765Z","steps":["trace[1873470680] 'agreement among raft nodes before linearized reading' (duration: 438.420566ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:10.241788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:09.803288Z","time spent":"438.496577ms","remote":"127.0.0.1:38734","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-12T03:40:10.97461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.202981ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:40:10.97481Z","caller":"traceutil/trace.go:171","msg":"trace[315236] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"720.864103ms","start":"2026-02-12T03:40:10.25393Z","end":"2026-02-12T03:40:10.974794Z","steps":["trace[315236] 'process raft request' (duration: 720.832282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:10.974882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:10.253917Z","time spent":"720.919456ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:10.975195Z","caller":"traceutil/trace.go:171","msg":"trace[121268208] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"723.236837ms","start":"2026-02-12T03:40:10.251945Z","end":"2026-02-12T03:40:10.975182Z","steps":["trace[121268208] 'process raft request' (duration: 467.383308ms)","trace[121268208] 'compare' (duration: 255.049788ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:40:10.975242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:10.251924Z","time spent":"723.291438ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:10.975332Z","caller":"traceutil/trace.go:171","msg":"trace[691186451] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"721.555732ms","start":"2026-02-12T03:40:10.253768Z","end":"2026-02-12T03:40:10.975324Z","steps":["trace[691186451] 'process raft request' (duration: 720.928016ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:10.975368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:10.253752Z","time spent":"721.595104ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:13.061821Z","caller":"traceutil/trace.go:171","msg":"trace[1999623780] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"443.919071ms","start":"2026-02-12T03:40:12.617883Z","end":"2026-02-12T03:40:13.061802Z","steps":["trace[1999623780] 'process raft request' (duration: 359.015435ms)","trace[1999623780] 'compare' (duration: 84.528256ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:40:13.061919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:12.617869Z","time spent":"444.011403ms","remote":"127.0.0.1:40630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":846,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T03:40:13.066167Z","caller":"traceutil/trace.go:171","msg":"trace[1450199505] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:532; }","duration":"258.24258ms","start":"2026-02-12T03:40:12.807914Z","end":"2026-02-12T03:40:13.066156Z","steps":["trace[1450199505] 'read index received' (duration: 169.059262ms)","trace[1450199505] 'applied index is now lower than readState.Index' (duration: 89.182728ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:40:13.066231Z","caller":"traceutil/trace.go:171","msg":"trace[884503807] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"446.884309ms","start":"2026-02-12T03:40:12.619339Z","end":"2026-02-12T03:40:13.066223Z","steps":["trace[884503807] 'process raft request' (duration: 446.728434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:13.066304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:12.619332Z","time spent":"446.913811ms","remote":"127.0.0.1:40734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17156,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:40:13.066464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.545299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-12T03:40:13.066491Z","caller":"traceutil/trace.go:171","msg":"trace[1227091788] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:515; }","duration":"258.594569ms","start":"2026-02-12T03:40:12.807888Z","end":"2026-02-12T03:40:13.066483Z","steps":["trace[1227091788] 'agreement among raft nodes before linearized reading' (duration: 258.549148ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:21.994257Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605826620566269771,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-12T03:40:22.39994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.231559788s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:40:22.400033Z","caller":"traceutil/trace.go:171","msg":"trace[48848694] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:613; }","duration":"2.231689981s","start":"2026-02-12T03:40:20.168323Z","end":"2026-02-12T03:40:22.400013Z","steps":["trace[48848694] 'range keys from in-memory index tree' (duration: 2.231506206s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.40007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:20.168308Z","time spent":"2.231752583s","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 "} {"level":"warn","ts":"2026-02-12T03:40:22.400253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.231834665s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:40:22.400279Z","caller":"traceutil/trace.go:171","msg":"trace[653444054] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:613; }","duration":"2.231886096s","start":"2026-02-12T03:40:20.168385Z","end":"2026-02-12T03:40:22.400271Z","steps":["trace[653444054] 'range keys from in-memory index tree' (duration: 2.231763473s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.400303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:20.16837Z","time spent":"2.231925477s","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 "} {"level":"warn","ts":"2026-02-12T03:40:22.400406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.231982598s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:40:22.40043Z","caller":"traceutil/trace.go:171","msg":"trace[1180930313] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:613; }","duration":"2.23201419s","start":"2026-02-12T03:40:20.168408Z","end":"2026-02-12T03:40:22.400423Z","steps":["trace[1180930313] 'count revisions from in-memory index tree' (duration: 2.231903447s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.400648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.287940167s","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-12T03:40:22.400717Z","caller":"traceutil/trace.go:171","msg":"trace[724868921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"1.28804187s","start":"2026-02-12T03:40:21.112657Z","end":"2026-02-12T03:40:22.400698Z","steps":["trace[724868921] 'range keys from in-memory index tree' (duration: 1.287809184s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.40077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:21.112652Z","time spent":"1.288109052s","remote":"127.0.0.1:38734","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-12T03:40:22.400454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:20.168404Z","time spent":"2.23204211s","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-02-12T03:40:22.401305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.944754104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:40:22.401367Z","caller":"traceutil/trace.go:171","msg":"trace[930235998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"1.944836077s","start":"2026-02-12T03:40:20.456518Z","end":"2026-02-12T03:40:22.401354Z","steps":["trace[930235998] 'range keys from in-memory index tree' (duration: 1.944707933s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.401379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140539585s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-02-12T03:40:22.401398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:20.456503Z","time spent":"1.944886538s","remote":"127.0.0.1:40542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-12T03:40:22.401412Z","caller":"traceutil/trace.go:171","msg":"trace[1536760667] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:613; }","duration":"1.140598518s","start":"2026-02-12T03:40:21.260804Z","end":"2026-02-12T03:40:22.401403Z","steps":["trace[1536760667] 'range keys from in-memory index tree' (duration: 1.140421233s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.401439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:21.26079Z","time spent":"1.140642109s","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-12T03:40:22.401635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.833886985s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-jlws6.189362b774c3021e\" ","response":"range_response_count:1 size:795"} {"level":"info","ts":"2026-02-12T03:40:22.401669Z","caller":"traceutil/trace.go:171","msg":"trace[95714254] range","detail":"{range_begin:/registry/events/kube-system/cilium-jlws6.189362b774c3021e; range_end:; response_count:1; response_revision:613; }","duration":"1.833946266s","start":"2026-02-12T03:40:20.567713Z","end":"2026-02-12T03:40:22.401659Z","steps":["trace[95714254] 'range keys from in-memory index tree' (duration: 1.833802642s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.401701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:20.567699Z","time spent":"1.833994497s","remote":"127.0.0.1:40630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":818,"request content":"key:\"/registry/events/kube-system/cilium-jlws6.189362b774c3021e\" "} {"level":"warn","ts":"2026-02-12T03:40:22.4017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.978428ms","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-12T03:40:22.401757Z","caller":"traceutil/trace.go:171","msg":"trace[1171577651] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:613; }","duration":"775.03515ms","start":"2026-02-12T03:40:21.626713Z","end":"2026-02-12T03:40:22.401749Z","steps":["trace[1171577651] 'range keys from in-memory index tree' (duration: 774.970768ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.402264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.295608289s","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-12T03:40:22.402298Z","caller":"traceutil/trace.go:171","msg":"trace[1898852706] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:613; }","duration":"1.295662981s","start":"2026-02-12T03:40:21.106625Z","end":"2026-02-12T03:40:22.402288Z","steps":["trace[1898852706] 'range keys from in-memory index tree' (duration: 1.295535128s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.40233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:21.106612Z","time spent":"1.295709172s","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-12T03:40:22.402499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.293303178s","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-12T03:40:22.402526Z","caller":"traceutil/trace.go:171","msg":"trace[690823698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"1.293337489s","start":"2026-02-12T03:40:21.10918Z","end":"2026-02-12T03:40:22.402517Z","steps":["trace[690823698] 'range keys from in-memory index tree' (duration: 1.293248507s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.402554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:21.109176Z","time spent":"1.29337021s","remote":"127.0.0.1:38734","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-12T03:40:22.495168Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605826620566269771,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-12T03:40:22.768615Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.43801106s","expected-duration":"1s"} {"level":"info","ts":"2026-02-12T03:40:22.769083Z","caller":"traceutil/trace.go:171","msg":"trace[221590278] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.438531814s","start":"2026-02-12T03:40:21.330518Z","end":"2026-02-12T03:40:22.769049Z","steps":["trace[221590278] 'process raft request' (duration: 1.43837916s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:22.769297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:21.3305Z","time spent":"1.438682638s","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:23.125022Z","caller":"traceutil/trace.go:171","msg":"trace[1442272874] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"709.414022ms","start":"2026-02-12T03:40:22.415579Z","end":"2026-02-12T03:40:23.124993Z","steps":["trace[1442272874] 'process raft request' (duration: 709.292009ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:23.125041Z","caller":"traceutil/trace.go:171","msg":"trace[861285029] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:636; }","duration":"1.631487734s","start":"2026-02-12T03:40:21.493537Z","end":"2026-02-12T03:40:23.125024Z","steps":["trace[861285029] 'read index received' (duration: 1.275634193s)","trace[861285029] 'applied index is now lower than readState.Index' (duration: 355.853051ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:40:23.125185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:22.415573Z","time spent":"709.513125ms","remote":"127.0.0.1:40630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:23.125335Z","caller":"traceutil/trace.go:171","msg":"trace[1756081274] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"703.476617ms","start":"2026-02-12T03:40:22.421851Z","end":"2026-02-12T03:40:23.125328Z","steps":["trace[1756081274] 'process raft request' (duration: 703.098186ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:23.125405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:22.421841Z","time spent":"703.509787ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:23.125516Z","caller":"traceutil/trace.go:171","msg":"trace[1967957153] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"700.932459ms","start":"2026-02-12T03:40:22.424576Z","end":"2026-02-12T03:40:23.125508Z","steps":["trace[1967957153] 'process raft request' (duration: 700.432246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:23.125594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:22.42457Z","time spent":"700.96595ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:23.125659Z","caller":"traceutil/trace.go:171","msg":"trace[912003454] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"703.730553ms","start":"2026-02-12T03:40:22.421923Z","end":"2026-02-12T03:40:23.125653Z","steps":["trace[912003454] 'process raft request' (duration: 703.069555ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:23.125687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:22.42192Z","time spent":"703.752933ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:40:23.12552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.631981177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-12T03:40:23.125718Z","caller":"traceutil/trace.go:171","msg":"trace[1581028729] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:619; }","duration":"1.632198653s","start":"2026-02-12T03:40:21.49351Z","end":"2026-02-12T03:40:23.125709Z","steps":["trace[1581028729] 'agreement among raft nodes before linearized reading' (duration: 1.631988878s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:23.125742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:21.493496Z","time spent":"1.632239584s","remote":"127.0.0.1:40572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"info","ts":"2026-02-12T03:40:23.125756Z","caller":"traceutil/trace.go:171","msg":"trace[62238547] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"703.848495ms","start":"2026-02-12T03:40:22.421899Z","end":"2026-02-12T03:40:23.125747Z","steps":["trace[62238547] 'process raft request' (duration: 703.079005ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:23.12578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:22.421896Z","time spent":"703.871566ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:23.146397Z","caller":"traceutil/trace.go:171","msg":"trace[152558331] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"161.242967ms","start":"2026-02-12T03:40:22.985132Z","end":"2026-02-12T03:40:23.146375Z","steps":["trace[152558331] 'process raft request' (duration: 161.118404ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:23.147152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.587127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:40:23.14719Z","caller":"traceutil/trace.go:171","msg":"trace[2074795004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"731.653608ms","start":"2026-02-12T03:40:22.415525Z","end":"2026-02-12T03:40:23.147179Z","steps":["trace[2074795004] 'agreement among raft nodes before linearized reading' (duration: 731.563956ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:23.147219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:22.415519Z","time spent":"731.693449ms","remote":"127.0.0.1:40544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-12T03:40:23.147446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.418039754s","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-12T03:40:23.147475Z","caller":"traceutil/trace.go:171","msg":"trace[2021542622] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"1.418091205s","start":"2026-02-12T03:40:21.729373Z","end":"2026-02-12T03:40:23.147465Z","steps":["trace[2021542622] 'agreement among raft nodes before linearized reading' (duration: 1.417977212s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:23.147499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:21.729359Z","time spent":"1.418134266s","remote":"127.0.0.1:38734","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-12T03:40:23.418218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.947814ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-02-12T03:40:23.4183Z","caller":"traceutil/trace.go:171","msg":"trace[1282546033] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"271.215873ms","start":"2026-02-12T03:40:23.147068Z","end":"2026-02-12T03:40:23.418284Z","steps":["trace[1282546033] 'read index received' (duration: 54.191837ms)","trace[1282546033] 'applied index is now lower than readState.Index' (duration: 217.022856ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:40:23.418563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.701058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-jlws6.189362b774c3021e\" ","response":"range_response_count:1 size:795"} {"level":"info","ts":"2026-02-12T03:40:23.418592Z","caller":"traceutil/trace.go:171","msg":"trace[1096272744] range","detail":"{range_begin:/registry/events/kube-system/cilium-jlws6.189362b774c3021e; range_end:; response_count:1; response_revision:620; }","duration":"284.763ms","start":"2026-02-12T03:40:23.13382Z","end":"2026-02-12T03:40:23.418583Z","steps":["trace[1096272744] 'agreement among raft nodes before linearized reading' (duration: 284.698048ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:23.422237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.097542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:40:23.422275Z","caller":"traceutil/trace.go:171","msg":"trace[652132408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"243.154764ms","start":"2026-02-12T03:40:23.17911Z","end":"2026-02-12T03:40:23.422265Z","steps":["trace[652132408] 'agreement among raft nodes before linearized reading' (duration: 243.071252ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:23.422489Z","caller":"traceutil/trace.go:171","msg":"trace[1155220094] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"244.221892ms","start":"2026-02-12T03:40:23.178257Z","end":"2026-02-12T03:40:23.422479Z","steps":["trace[1155220094] 'process raft request' (duration: 243.600886ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:23.422714Z","caller":"traceutil/trace.go:171","msg":"trace[367823145] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"243.280777ms","start":"2026-02-12T03:40:23.179417Z","end":"2026-02-12T03:40:23.422698Z","steps":["trace[367823145] 'process raft request' (duration: 242.531297ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:23.422864Z","caller":"traceutil/trace.go:171","msg":"trace[1406638997] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"239.390224ms","start":"2026-02-12T03:40:23.183465Z","end":"2026-02-12T03:40:23.422855Z","steps":["trace[1406638997] 'process raft request' (duration: 238.637695ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:23.426325Z","caller":"traceutil/trace.go:171","msg":"trace[517601541] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"241.783179ms","start":"2026-02-12T03:40:23.18453Z","end":"2026-02-12T03:40:23.426314Z","steps":["trace[517601541] 'process raft request' (duration: 237.608559ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:40:33.100528Z","caller":"traceutil/trace.go:171","msg":"trace[1318090167] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"318.798605ms","start":"2026-02-12T03:40:32.781713Z","end":"2026-02-12T03:40:33.100512Z","steps":["trace[1318090167] 'process raft request' (duration: 318.686342ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:33.100644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:32.781698Z","time spent":"318.883188ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:40:49.543157Z","caller":"traceutil/trace.go:171","msg":"trace[1632194248] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"197.362447ms","start":"2026-02-12T03:40:49.345774Z","end":"2026-02-12T03:40:49.543137Z","steps":["trace[1632194248] 'process raft request' (duration: 197.182223ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:49.766099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.981981ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:40:49.766326Z","caller":"traceutil/trace.go:171","msg":"trace[1479309772] linearizableReadLoop","detail":"{readStateIndex:773; appliedIndex:771; }","duration":"383.243724ms","start":"2026-02-12T03:40:49.383065Z","end":"2026-02-12T03:40:49.766308Z","steps":["trace[1479309772] 'read index received' (duration: 159.89935ms)","trace[1479309772] 'applied index is now lower than readState.Index' (duration: 223.342594ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:40:49.766506Z","caller":"traceutil/trace.go:171","msg":"trace[1566071346] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"418.474053ms","start":"2026-02-12T03:40:49.348019Z","end":"2026-02-12T03:40:49.766494Z","steps":["trace[1566071346] 'process raft request' (duration: 211.859765ms)","trace[1566071346] 'compare' (duration: 205.579841ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:40:49.766673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:49.348006Z","time spent":"418.594266ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:40:49.768172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.187828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T03:40:49.768357Z","caller":"traceutil/trace.go:171","msg":"trace[1056174725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:744; }","duration":"385.312378ms","start":"2026-02-12T03:40:49.383019Z","end":"2026-02-12T03:40:49.768331Z","steps":["trace[1056174725] 'agreement among raft nodes before linearized reading' (duration: 383.85779ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:49.768429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:49.382991Z","time spent":"385.40762ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-12T03:40:49.768675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.279541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T03:40:49.768723Z","caller":"traceutil/trace.go:171","msg":"trace[726154551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:744; }","duration":"384.353603ms","start":"2026-02-12T03:40:49.384356Z","end":"2026-02-12T03:40:49.768709Z","steps":["trace[726154551] 'agreement among raft nodes before linearized reading' (duration: 384.221089ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:49.76876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:49.384342Z","time spent":"384.408554ms","remote":"127.0.0.1:38734","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-12T03:40:49.768957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.262886ms","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-12T03:40:49.768997Z","caller":"traceutil/trace.go:171","msg":"trace[816581427] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:744; }","duration":"240.330687ms","start":"2026-02-12T03:40:49.528655Z","end":"2026-02-12T03:40:49.768985Z","steps":["trace[816581427] 'agreement among raft nodes before linearized reading' (duration: 240.201324ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:49.769101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.985738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:40:49.769137Z","caller":"traceutil/trace.go:171","msg":"trace[878700229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:744; }","duration":"314.05036ms","start":"2026-02-12T03:40:49.455076Z","end":"2026-02-12T03:40:49.769127Z","steps":["trace[878700229] 'agreement among raft nodes before linearized reading' (duration: 314.000019ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:40:49.769173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:49.455062Z","time spent":"314.100831ms","remote":"127.0.0.1:40542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-12T03:40:51.726988Z","caller":"traceutil/trace.go:171","msg":"trace[1750640837] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"163.086173ms","start":"2026-02-12T03:40:51.563879Z","end":"2026-02-12T03:40:51.726965Z","steps":["trace[1750640837] 'process raft request' (duration: 146.389168ms)","trace[1750640837] 'compare' (duration: 15.922565ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:40:51.727119Z","caller":"traceutil/trace.go:171","msg":"trace[1266959967] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:778; }","duration":"162.842518ms","start":"2026-02-12T03:40:51.564254Z","end":"2026-02-12T03:40:51.727097Z","steps":["trace[1266959967] 'read index received' (duration: 145.952557ms)","trace[1266959967] 'applied index is now lower than readState.Index' (duration: 16.88822ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:40:51.727248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.972761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-02-12T03:40:51.727266Z","caller":"traceutil/trace.go:171","msg":"trace[1262219734] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:749; }","duration":"163.020132ms","start":"2026-02-12T03:40:51.56424Z","end":"2026-02-12T03:40:51.72726Z","steps":["trace[1262219734] 'agreement among raft nodes before linearized reading' (duration: 162.924499ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:41:18.195016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.320485ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:41:18.195112Z","caller":"traceutil/trace.go:171","msg":"trace[2113033495] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:911; }","duration":"279.259562ms","start":"2026-02-12T03:41:17.915819Z","end":"2026-02-12T03:41:18.195078Z","steps":["trace[2113033495] 'read index received' (duration: 12.775634ms)","trace[2113033495] 'applied index is now lower than readState.Index' (duration: 266.483188ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:41:18.195483Z","caller":"traceutil/trace.go:171","msg":"trace[1694831712] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"286.106751ms","start":"2026-02-12T03:41:17.909351Z","end":"2026-02-12T03:41:18.195457Z","steps":["trace[1694831712] 'process raft request' (duration: 19.269962ms)","trace[1694831712] 'compare' (duration: 264.95896ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:41:18.195917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.085394ms","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-12T03:41:18.195945Z","caller":"traceutil/trace.go:171","msg":"trace[947096393] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:875; }","duration":"280.152996ms","start":"2026-02-12T03:41:17.915783Z","end":"2026-02-12T03:41:18.195936Z","steps":["trace[947096393] 'agreement among raft nodes before linearized reading' (duration: 280.042513ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:41:18.196083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.07103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T03:41:18.196097Z","caller":"traceutil/trace.go:171","msg":"trace[1886210552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:875; }","duration":"243.093721ms","start":"2026-02-12T03:41:17.952999Z","end":"2026-02-12T03:41:18.196092Z","steps":["trace[1886210552] 'agreement among raft nodes before linearized reading' (duration: 243.05257ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:41:18.200009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.725411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T03:41:18.200066Z","caller":"traceutil/trace.go:171","msg":"trace[1826373683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:875; }","duration":"247.801332ms","start":"2026-02-12T03:41:17.952253Z","end":"2026-02-12T03:41:18.200055Z","steps":["trace[1826373683] 'agreement among raft nodes before linearized reading' (duration: 243.212983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:41:18.570483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.821623ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:41:18.570602Z","caller":"traceutil/trace.go:171","msg":"trace[1552927945] linearizableReadLoop","detail":"{readStateIndex:915; appliedIndex:913; }","duration":"301.258697ms","start":"2026-02-12T03:41:18.269332Z","end":"2026-02-12T03:41:18.570591Z","steps":["trace[1552927945] 'read index received' (duration: 30.192907ms)","trace[1552927945] 'applied index is now lower than readState.Index' (duration: 271.06511ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:41:18.570764Z","caller":"traceutil/trace.go:171","msg":"trace[1069333997] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"368.360676ms","start":"2026-02-12T03:41:18.202393Z","end":"2026-02-12T03:41:18.570754Z","steps":["trace[1069333997] 'process raft request' (duration: 97.201824ms)","trace[1069333997] 'compare' (duration: 270.655099ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:41:18.570809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:18.202378Z","time spent":"368.409907ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:41:18.570948Z","caller":"traceutil/trace.go:171","msg":"trace[1906229486] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"366.296452ms","start":"2026-02-12T03:41:18.204645Z","end":"2026-02-12T03:41:18.570941Z","steps":["trace[1906229486] 'process raft request' (duration: 365.910182ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:41:18.570985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:18.204638Z","time spent":"366.325153ms","remote":"127.0.0.1:38734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:41:18.571202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.872852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T03:41:18.571223Z","caller":"traceutil/trace.go:171","msg":"trace[1832574987] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:878; }","duration":"301.966594ms","start":"2026-02-12T03:41:18.26925Z","end":"2026-02-12T03:41:18.571216Z","steps":["trace[1832574987] 'agreement among raft nodes before linearized reading' (duration: 301.913553ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:41:18.571242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:18.269233Z","time spent":"302.004956ms","remote":"127.0.0.1:38746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-02-12T03:41:18.57133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.023801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:41:18.571345Z","caller":"traceutil/trace.go:171","msg":"trace[235379037] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:878; }","duration":"120.062741ms","start":"2026-02-12T03:41:18.451277Z","end":"2026-02-12T03:41:18.57134Z","steps":["trace[235379037] 'agreement among raft nodes before linearized reading' (duration: 120.039831ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:41:35.651925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.363633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:41:35.66291Z","caller":"traceutil/trace.go:171","msg":"trace[1214183560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:991; }","duration":"198.499136ms","start":"2026-02-12T03:41:35.453499Z","end":"2026-02-12T03:41:35.651998Z","steps":["trace[1214183560] 'range keys from in-memory index tree' (duration: 198.303212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:41:36.246466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.266584ms","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-12T03:41:36.246916Z","caller":"traceutil/trace.go:171","msg":"trace[1651711662] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:992; }","duration":"276.737107ms","start":"2026-02-12T03:41:35.970142Z","end":"2026-02-12T03:41:36.246879Z","steps":["trace[1651711662] 'range keys from in-memory index tree' (duration: 276.132471ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:41:36.257875Z","caller":"traceutil/trace.go:171","msg":"trace[849730611] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"286.010879ms","start":"2026-02-12T03:41:35.97185Z","end":"2026-02-12T03:41:36.257861Z","steps":["trace[849730611] 'process raft request' (duration: 285.905116ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:41:36.386499Z","caller":"traceutil/trace.go:171","msg":"trace[2000157641] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1033; }","duration":"107.119383ms","start":"2026-02-12T03:41:36.279356Z","end":"2026-02-12T03:41:36.386476Z","steps":["trace[2000157641] 'read index received' (duration: 105.854931ms)","trace[2000157641] 'applied index is now lower than readState.Index' (duration: 1.263632ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:41:36.386873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.494103ms","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-12T03:41:36.387578Z","caller":"traceutil/trace.go:171","msg":"trace[437254665] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:994; }","duration":"108.215113ms","start":"2026-02-12T03:41:36.279343Z","end":"2026-02-12T03:41:36.387558Z","steps":["trace[437254665] 'agreement among raft nodes before linearized reading' (duration: 107.348141ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:41:36.389284Z","caller":"traceutil/trace.go:171","msg":"trace[1349923312] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"136.680584ms","start":"2026-02-12T03:41:36.250197Z","end":"2026-02-12T03:41:36.386878Z","steps":["trace[1349923312] 'process raft request' (duration: 135.065282ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:42:13.17903Z","caller":"traceutil/trace.go:171","msg":"trace[536051587] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"137.389377ms","start":"2026-02-12T03:42:13.041617Z","end":"2026-02-12T03:42:13.179007Z","steps":["trace[536051587] 'process raft request' (duration: 137.225033ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:42:13.18075Z","caller":"traceutil/trace.go:171","msg":"trace[266484273] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"138.949988ms","start":"2026-02-12T03:42:13.041788Z","end":"2026-02-12T03:42:13.180738Z","steps":["trace[266484273] 'process raft request' (duration: 138.875235ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:42:53.103131Z","caller":"traceutil/trace.go:171","msg":"trace[121129223] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"102.488718ms","start":"2026-02-12T03:42:53.000619Z","end":"2026-02-12T03:42:53.103108Z","steps":["trace[121129223] 'read index received' (duration: 29.375214ms)","trace[121129223] 'applied index is now lower than readState.Index' (duration: 73.112584ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:42:53.103432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.794545ms","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-12T03:42:53.103485Z","caller":"traceutil/trace.go:171","msg":"trace[656072658] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1307; }","duration":"102.892538ms","start":"2026-02-12T03:42:53.000583Z","end":"2026-02-12T03:42:53.103475Z","steps":["trace[656072658] 'agreement among raft nodes before linearized reading' (duration: 102.705943ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:42:53.103711Z","caller":"traceutil/trace.go:171","msg":"trace[2044240741] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"158.820536ms","start":"2026-02-12T03:42:52.94488Z","end":"2026-02-12T03:42:53.103701Z","steps":["trace[2044240741] 'process raft request' (duration: 85.102897ms)","trace[2044240741] 'compare' (duration: 73.041622ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:42:57.273122Z","caller":"traceutil/trace.go:171","msg":"trace[1772391928] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"102.923469ms","start":"2026-02-12T03:42:57.170181Z","end":"2026-02-12T03:42:57.273105Z","steps":["trace[1772391928] 'process raft request' (duration: 102.819257ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:43:13.703992Z","caller":"traceutil/trace.go:171","msg":"trace[555711919] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"114.614075ms","start":"2026-02-12T03:43:13.58935Z","end":"2026-02-12T03:43:13.703964Z","steps":["trace[555711919] 'process raft request' (duration: 22.644523ms)","trace[555711919] 'compare' (duration: 91.570592ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:43:52.744537Z","caller":"traceutil/trace.go:171","msg":"trace[413623140] transaction","detail":"{read_only:false; response_revision:1551; number_of_response:1; }","duration":"191.502043ms","start":"2026-02-12T03:43:52.552999Z","end":"2026-02-12T03:43:52.744501Z","steps":["trace[413623140] 'process raft request' (duration: 106.646652ms)","trace[413623140] 'compare' (duration: 84.702887ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:44:00.886595Z","caller":"traceutil/trace.go:171","msg":"trace[1927045982] transaction","detail":"{read_only:false; response_revision:1584; number_of_response:1; }","duration":"108.0472ms","start":"2026-02-12T03:44:00.778331Z","end":"2026-02-12T03:44:00.886378Z","steps":["trace[1927045982] 'process raft request' (duration: 107.878696ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:44:03.548569Z","caller":"traceutil/trace.go:171","msg":"trace[1135843579] transaction","detail":"{read_only:false; response_revision:1593; number_of_response:1; }","duration":"131.287688ms","start":"2026-02-12T03:44:03.417258Z","end":"2026-02-12T03:44:03.548546Z","steps":["trace[1135843579] 'process raft request' (duration: 130.945819ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:44:04.297217Z","caller":"traceutil/trace.go:171","msg":"trace[659707499] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"164.2111ms","start":"2026-02-12T03:44:04.132972Z","end":"2026-02-12T03:44:04.297183Z","steps":["trace[659707499] 'process raft request' (duration: 75.670943ms)","trace[659707499] 'compare' (duration: 88.401344ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:44:44.298306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.806946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-02-12T03:44:44.29851Z","caller":"traceutil/trace.go:171","msg":"trace[1483266849] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1783; }","duration":"114.057082ms","start":"2026-02-12T03:44:44.184375Z","end":"2026-02-12T03:44:44.298432Z","steps":["trace[1483266849] 'range keys from in-memory index tree' (duration: 113.549889ms)"],"step_count":1}