{"level":"warn","ts":"2026-02-10T14:58:09.979142Z","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-10T14:58:09.97967Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.18: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.19.213.18:2380","--initial-cluster=instance=https://199.19.213.18:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.18:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.18: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-10T14:58:09.979786Z","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-10T14:58:09.97981Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.18:2380"]} {"level":"info","ts":"2026-02-10T14:58:09.979855Z","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-10T14:58:09.980589Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"]} {"level":"info","ts":"2026-02-10T14:58:09.980741Z","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.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.18: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-10T14:58:09.985414Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.244276ms"} {"level":"info","ts":"2026-02-10T14:58:10.001192Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6d0358acb671c233","cluster-id":"ba212af698de913f"} {"level":"info","ts":"2026-02-10T14:58:10.001468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=()"} {"level":"info","ts":"2026-02-10T14:58:10.001548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 0"} {"level":"info","ts":"2026-02-10T14:58:10.001635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6d0358acb671c233 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-10T14:58:10.001695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 1"} {"level":"info","ts":"2026-02-10T14:58:10.001779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"} {"level":"warn","ts":"2026-02-10T14:58:10.068679Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-10T14:58:10.093391Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-10T14:58:10.119439Z","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-10T14:58:10.149275Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6d0358acb671c233","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-10T14:58:10.158985Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6d0358acb671c233","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-10T14:58:10.159351Z","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-10T14:58:10.159448Z","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-10T14:58:10.159528Z","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-10T14:58:10.166169Z","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-10T14:58:10.166427Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6d0358acb671c233","initial-advertise-peer-urls":["https://199.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-10T14:58:10.16654Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-10T14:58:10.166689Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.18:2380"} {"level":"info","ts":"2026-02-10T14:58:10.16676Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.18:2380"} {"level":"info","ts":"2026-02-10T14:58:10.167565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"} {"level":"info","ts":"2026-02-10T14:58:10.169235Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","added-peer-id":"6d0358acb671c233","added-peer-peer-urls":["https://199.19.213.18:2380"]} {"level":"info","ts":"2026-02-10T14:58:10.405352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 is starting a new election at term 1"} {"level":"info","ts":"2026-02-10T14:58:10.405401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-10T14:58:10.405423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgPreVoteResp from 6d0358acb671c233 at term 1"} {"level":"info","ts":"2026-02-10T14:58:10.405437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became candidate at term 2"} {"level":"info","ts":"2026-02-10T14:58:10.405443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgVoteResp from 6d0358acb671c233 at term 2"} {"level":"info","ts":"2026-02-10T14:58:10.405451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became leader at term 2"} {"level":"info","ts":"2026-02-10T14:58:10.405462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6d0358acb671c233 elected leader 6d0358acb671c233 at term 2"} {"level":"info","ts":"2026-02-10T14:58:10.4136Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:58:10.424359Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6d0358acb671c233","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.18:2379]}","request-path":"/0/members/6d0358acb671c233/attributes","cluster-id":"ba212af698de913f","publish-timeout":"7s"} {"level":"info","ts":"2026-02-10T14:58:10.424521Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T14:58:10.439002Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T14:58:10.439323Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.18:2379"} {"level":"info","ts":"2026-02-10T14:58:10.439566Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:58:10.442182Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:58:10.441472Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-10T14:58:10.445342Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-10T14:58:10.445383Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:58:10.459962Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-10T14:58:19.755554Z","caller":"traceutil/trace.go:171","msg":"trace[1128208972] linearizableReadLoop","detail":"{readStateIndex:349; appliedIndex:348; }","duration":"147.95743ms","start":"2026-02-10T14:58:19.607553Z","end":"2026-02-10T14:58:19.75551Z","steps":["trace[1128208972] 'read index received' (duration: 147.787389ms)","trace[1128208972] 'applied index is now lower than readState.Index' (duration: 169.371µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:19.755725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.138631ms","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-10T14:58:19.755762Z","caller":"traceutil/trace.go:171","msg":"trace[2126871357] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:339; }","duration":"148.235167ms","start":"2026-02-10T14:58:19.607517Z","end":"2026-02-10T14:58:19.755752Z","steps":["trace[2126871357] 'agreement among raft nodes before linearized reading' (duration: 148.106239ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:19.756158Z","caller":"traceutil/trace.go:171","msg":"trace[1998661431] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"174.030564ms","start":"2026-02-10T14:58:19.582112Z","end":"2026-02-10T14:58:19.756143Z","steps":["trace[1998661431] 'process raft request' (duration: 173.294759ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:20.640434Z","caller":"traceutil/trace.go:171","msg":"trace[144040952] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"877.110351ms","start":"2026-02-10T14:58:19.763292Z","end":"2026-02-10T14:58:20.640402Z","steps":["trace[144040952] 'process raft request' (duration: 869.319071ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:20.641696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:19.763278Z","time spent":"877.365797ms","remote":"127.0.0.1:37706","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-10T14:58:20.642558Z","caller":"traceutil/trace.go:171","msg":"trace[244727724] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"877.053678ms","start":"2026-02-10T14:58:19.764942Z","end":"2026-02-10T14:58:20.641995Z","steps":["trace[244727724] 'process raft request' (duration: 874.915086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:20.642735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:19.764934Z","time spent":"877.72707ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":209,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:58:20.852549Z","caller":"traceutil/trace.go:171","msg":"trace[2124863137] linearizableReadLoop","detail":"{readStateIndex:362; appliedIndex:358; }","duration":"103.47288ms","start":"2026-02-10T14:58:20.749052Z","end":"2026-02-10T14:58:20.852524Z","steps":["trace[2124863137] 'read index received' (duration: 77.732543ms)","trace[2124863137] 'applied index is now lower than readState.Index' (duration: 25.739537ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:58:20.852868Z","caller":"traceutil/trace.go:171","msg":"trace[261750082] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"107.571003ms","start":"2026-02-10T14:58:20.745286Z","end":"2026-02-10T14:58:20.852857Z","steps":["trace[261750082] 'process raft request' (duration: 107.056451ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:20.853262Z","caller":"traceutil/trace.go:171","msg":"trace[122592434] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"107.731894ms","start":"2026-02-10T14:58:20.745523Z","end":"2026-02-10T14:58:20.853255Z","steps":["trace[122592434] 'process raft request' (duration: 106.903382ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:20.853584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.519925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-10T14:58:20.853675Z","caller":"traceutil/trace.go:171","msg":"trace[970870046] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:352; }","duration":"104.656084ms","start":"2026-02-10T14:58:20.749006Z","end":"2026-02-10T14:58:20.853662Z","steps":["trace[970870046] 'agreement among raft nodes before linearized reading' (duration: 104.539077ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:20.85385Z","caller":"traceutil/trace.go:171","msg":"trace[821191422] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"107.84779ms","start":"2026-02-10T14:58:20.745755Z","end":"2026-02-10T14:58:20.853603Z","steps":["trace[821191422] 'process raft request' (duration: 106.740361ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:20.854385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.212341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-10T14:58:20.854455Z","caller":"traceutil/trace.go:171","msg":"trace[876475950] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:352; }","duration":"101.336539ms","start":"2026-02-10T14:58:20.753101Z","end":"2026-02-10T14:58:20.854437Z","steps":["trace[876475950] 'agreement among raft nodes before linearized reading' (duration: 101.158918ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:20.856964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.710025ms","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-10T14:58:20.865586Z","caller":"traceutil/trace.go:171","msg":"trace[1526230941] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:352; }","duration":"112.271723ms","start":"2026-02-10T14:58:20.753183Z","end":"2026-02-10T14:58:20.865455Z","steps":["trace[1526230941] 'agreement among raft nodes before linearized reading' (duration: 102.784148ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:21.24413Z","caller":"traceutil/trace.go:171","msg":"trace[1637276164] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"103.158571ms","start":"2026-02-10T14:58:21.140945Z","end":"2026-02-10T14:58:21.244103Z","steps":["trace[1637276164] 'process raft request' (duration: 94.979636ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:22.941355Z","caller":"traceutil/trace.go:171","msg":"trace[1182830112] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"100.080579ms","start":"2026-02-10T14:58:22.841192Z","end":"2026-02-10T14:58:22.941273Z","steps":["trace[1182830112] 'process raft request' (duration: 97.401503ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:26.193761Z","caller":"traceutil/trace.go:171","msg":"trace[1478225312] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"236.774116ms","start":"2026-02-10T14:58:25.956965Z","end":"2026-02-10T14:58:26.193739Z","steps":["trace[1478225312] 'process raft request' (duration: 236.652919ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:26.226648Z","caller":"traceutil/trace.go:171","msg":"trace[1408076312] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:421; }","duration":"117.730039ms","start":"2026-02-10T14:58:26.108901Z","end":"2026-02-10T14:58:26.226631Z","steps":["trace[1408076312] 'read index received' (duration: 88.883374ms)","trace[1408076312] 'applied index is now lower than readState.Index' (duration: 28.846034ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:26.22675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.830185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6894"} {"level":"info","ts":"2026-02-10T14:58:26.226766Z","caller":"traceutil/trace.go:171","msg":"trace[1760013264] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:410; }","duration":"117.889999ms","start":"2026-02-10T14:58:26.108871Z","end":"2026-02-10T14:58:26.226761Z","steps":["trace[1760013264] 'agreement among raft nodes before linearized reading' (duration: 117.825145ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:26.227018Z","caller":"traceutil/trace.go:171","msg":"trace[1001831364] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"159.287703ms","start":"2026-02-10T14:58:26.067725Z","end":"2026-02-10T14:58:26.227013Z","steps":["trace[1001831364] 'process raft request' (duration: 158.798683ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:27.219246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700300478993524,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:58:27.339081Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.10273596s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-10T14:58:27.748811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.350028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:58:27.748937Z","caller":"traceutil/trace.go:171","msg":"trace[1829259078] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"1.030473348s","start":"2026-02-10T14:58:26.718449Z","end":"2026-02-10T14:58:27.748922Z","steps":["trace[1829259078] 'read index received' (duration: 620.765758ms)","trace[1829259078] 'applied index is now lower than readState.Index' (duration: 409.7063ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:58:27.749133Z","caller":"traceutil/trace.go:171","msg":"trace[1439829941] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"1.512873417s","start":"2026-02-10T14:58:26.236248Z","end":"2026-02-10T14:58:27.749121Z","steps":["trace[1439829941] 'process raft request' (duration: 1.103016267s)","trace[1439829941] 'compare' (duration: 408.384589ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:27.749191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:26.236229Z","time spent":"1.51293001s","remote":"127.0.0.1:37634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6879,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:58:27.751359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03289163s","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-10T14:58:27.751415Z","caller":"traceutil/trace.go:171","msg":"trace[1112430042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:411; }","duration":"1.032978905s","start":"2026-02-10T14:58:26.718423Z","end":"2026-02-10T14:58:27.751402Z","steps":["trace[1112430042] 'agreement among raft nodes before linearized reading' (duration: 1.032869138s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:27.751449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:26.718409Z","time spent":"1.033030808s","remote":"127.0.0.1:37706","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-10T14:58:27.751602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.581888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-10T14:58:27.751621Z","caller":"traceutil/trace.go:171","msg":"trace[1744712128] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:411; }","duration":"981.632571ms","start":"2026-02-10T14:58:26.769982Z","end":"2026-02-10T14:58:27.751615Z","steps":["trace[1744712128] 'agreement among raft nodes before linearized reading' (duration: 981.600779ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:27.75164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:26.769963Z","time spent":"981.672813ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T14:58:27.751752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.583856ms","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-10T14:58:27.751771Z","caller":"traceutil/trace.go:171","msg":"trace[523630379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:411; }","duration":"915.784018ms","start":"2026-02-10T14:58:26.83598Z","end":"2026-02-10T14:58:27.751764Z","steps":["trace[523630379] 'agreement among raft nodes before linearized reading' (duration: 915.747756ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:27.751787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:26.835958Z","time spent":"915.82547ms","remote":"127.0.0.1:37706","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-10T14:58:27.751864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.612068ms","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-10T14:58:27.751881Z","caller":"traceutil/trace.go:171","msg":"trace[664592151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:411; }","duration":"980.65149ms","start":"2026-02-10T14:58:26.771224Z","end":"2026-02-10T14:58:27.751875Z","steps":["trace[664592151] 'agreement among raft nodes before linearized reading' (duration: 980.624878ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:27.751898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:26.771213Z","time spent":"980.680162ms","remote":"127.0.0.1:37706","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-10T14:58:45.312193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.572646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-92vf7\" ","response":"range_response_count:1 size:4635"} {"level":"info","ts":"2026-02-10T14:58:45.312259Z","caller":"traceutil/trace.go:171","msg":"trace[1836733024] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-92vf7; range_end:; response_count:1; response_revision:539; }","duration":"489.677321ms","start":"2026-02-10T14:58:44.822569Z","end":"2026-02-10T14:58:45.312246Z","steps":["trace[1836733024] 'range keys from in-memory index tree' (duration: 489.484349ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:45.312291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:44.822554Z","time spent":"489.730719ms","remote":"127.0.0.1:37634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4658,"request content":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-92vf7\" "} {"level":"info","ts":"2026-02-10T14:58:45.324237Z","caller":"traceutil/trace.go:171","msg":"trace[1421448776] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"476.476012ms","start":"2026-02-10T14:58:44.847748Z","end":"2026-02-10T14:58:45.324224Z","steps":["trace[1421448776] 'process raft request' (duration: 476.400285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:45.324315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:44.847728Z","time spent":"476.551659ms","remote":"127.0.0.1:37492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:58:45.32454Z","caller":"traceutil/trace.go:171","msg":"trace[1422981464] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:557; }","duration":"389.088111ms","start":"2026-02-10T14:58:44.935446Z","end":"2026-02-10T14:58:45.324534Z","steps":["trace[1422981464] 'read index received' (duration: 389.085381ms)","trace[1422981464] 'applied index is now lower than readState.Index' (duration: 2.29µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:45.324585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.171998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:45.3246Z","caller":"traceutil/trace.go:171","msg":"trace[23182014] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"389.237505ms","start":"2026-02-10T14:58:44.935359Z","end":"2026-02-10T14:58:45.324596Z","steps":["trace[23182014] 'agreement among raft nodes before linearized reading' (duration: 389.194217ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:45.324615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:44.935297Z","time spent":"389.313922ms","remote":"127.0.0.1:37436","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-10T14:58:45.371468Z","caller":"traceutil/trace.go:171","msg":"trace[1762679944] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"323.61583ms","start":"2026-02-10T14:58:45.047834Z","end":"2026-02-10T14:58:45.371449Z","steps":["trace[1762679944] 'process raft request' (duration: 323.175297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:45.371559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:45.047818Z","time spent":"323.698257ms","remote":"127.0.0.1:37492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:58:45.371645Z","caller":"traceutil/trace.go:171","msg":"trace[1042786413] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"124.916882ms","start":"2026-02-10T14:58:45.246721Z","end":"2026-02-10T14:58:45.371638Z","steps":["trace[1042786413] 'process raft request' (duration: 124.387762ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:45.515178Z","caller":"traceutil/trace.go:171","msg":"trace[723266863] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"107.296405ms","start":"2026-02-10T14:58:45.407863Z","end":"2026-02-10T14:58:45.515159Z","steps":["trace[723266863] 'process raft request' (duration: 16.331056ms)","trace[723266863] 'compare' (duration: 90.727508ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:46.389491Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700300478993781,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:58:46.889806Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700300478993781,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:58:47.172954Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.32738482s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T14:58:47.17341Z","caller":"traceutil/trace.go:171","msg":"trace[1528854412] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"1.327905921s","start":"2026-02-10T14:58:45.845483Z","end":"2026-02-10T14:58:47.173389Z","steps":["trace[1528854412] 'process raft request' (duration: 1.327743297s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.173623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:45.845464Z","time spent":"1.328104454s","remote":"127.0.0.1:37492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:58:47.179164Z","caller":"traceutil/trace.go:171","msg":"trace[1622546703] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"552.46711ms","start":"2026-02-10T14:58:46.626681Z","end":"2026-02-10T14:58:47.179148Z","steps":["trace[1622546703] 'process raft request' (duration: 551.815054ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.179345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:46.626661Z","time spent":"552.548328ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:58:47.180137Z","caller":"traceutil/trace.go:171","msg":"trace[1944209112] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"551.905373ms","start":"2026-02-10T14:58:46.62822Z","end":"2026-02-10T14:58:47.180126Z","steps":["trace[1944209112] 'process raft request' (duration: 550.550322ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.180242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:46.628211Z","time spent":"551.957331ms","remote":"127.0.0.1:37630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4407,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:58:47.180945Z","caller":"traceutil/trace.go:171","msg":"trace[471151406] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:576; }","duration":"1.289780515s","start":"2026-02-10T14:58:45.889242Z","end":"2026-02-10T14:58:47.179023Z","steps":["trace[471151406] 'read index received' (duration: 1.284158004s)","trace[471151406] 'applied index is now lower than readState.Index' (duration: 5.621601ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:47.18103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.291781114s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-10T14:58:47.181251Z","caller":"traceutil/trace.go:171","msg":"trace[2115278080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:561; }","duration":"1.291983987s","start":"2026-02-10T14:58:45.889213Z","end":"2026-02-10T14:58:47.181197Z","steps":["trace[2115278080] 'agreement among raft nodes before linearized reading' (duration: 1.291775794s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.181383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:45.889198Z","time spent":"1.292086712s","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T14:58:47.181947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"851.589213ms","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":"info","ts":"2026-02-10T14:58:47.182017Z","caller":"traceutil/trace.go:171","msg":"trace[1792687083] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:561; }","duration":"851.653371ms","start":"2026-02-10T14:58:46.33032Z","end":"2026-02-10T14:58:47.181974Z","steps":["trace[1792687083] 'agreement among raft nodes before linearized reading' (duration: 851.519086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.182133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:46.330291Z","time spent":"851.814825ms","remote":"127.0.0.1:37706","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-10T14:58:47.18231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.292779239s","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-10T14:58:47.182415Z","caller":"traceutil/trace.go:171","msg":"trace[635707389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"1.292925653s","start":"2026-02-10T14:58:45.889478Z","end":"2026-02-10T14:58:47.182404Z","steps":["trace[635707389] 'agreement among raft nodes before linearized reading' (duration: 1.2919119s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.183535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:45.88946Z","time spent":"1.294071253s","remote":"127.0.0.1:37706","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-10T14:58:47.182606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.730677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-02-10T14:58:47.183834Z","caller":"traceutil/trace.go:171","msg":"trace[1488912249] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:561; }","duration":"138.981442ms","start":"2026-02-10T14:58:47.044831Z","end":"2026-02-10T14:58:47.183812Z","steps":["trace[1488912249] 'agreement among raft nodes before linearized reading' (duration: 137.659938ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.182678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.716358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-02-10T14:58:47.184349Z","caller":"traceutil/trace.go:171","msg":"trace[2010616044] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:561; }","duration":"339.308422ms","start":"2026-02-10T14:58:46.844905Z","end":"2026-02-10T14:58:47.184213Z","steps":["trace[2010616044] 'agreement among raft nodes before linearized reading' (duration: 337.739157ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.18438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:46.844887Z","time spent":"339.484525ms","remote":"127.0.0.1:37492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4106,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-02-10T14:58:47.182784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.13797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-10T14:58:47.184694Z","caller":"traceutil/trace.go:171","msg":"trace[93026410] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:561; }","duration":"539.080432ms","start":"2026-02-10T14:58:46.645606Z","end":"2026-02-10T14:58:47.184686Z","steps":["trace[93026410] 'agreement among raft nodes before linearized reading' (duration: 537.088992ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.18476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:46.64557Z","time spent":"539.182387ms","remote":"127.0.0.1:37492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4203,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-02-10T14:58:47.182877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.816917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:47.184956Z","caller":"traceutil/trace.go:171","msg":"trace[223135463] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:561; }","duration":"939.947081ms","start":"2026-02-10T14:58:46.245001Z","end":"2026-02-10T14:58:47.184948Z","steps":["trace[223135463] 'agreement among raft nodes before linearized reading' (duration: 937.852225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.185033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:46.244984Z","time spent":"940.041349ms","remote":"127.0.0.1:37492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-10T14:58:47.182972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.539522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:47.185162Z","caller":"traceutil/trace.go:171","msg":"trace[1830100659] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:561; }","duration":"696.726084ms","start":"2026-02-10T14:58:46.488395Z","end":"2026-02-10T14:58:47.185121Z","steps":["trace[1830100659] 'agreement among raft nodes before linearized reading' (duration: 694.404946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.18519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:46.488381Z","time spent":"696.801652ms","remote":"127.0.0.1:37540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-10T14:58:47.183059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137777029s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:47.185365Z","caller":"traceutil/trace.go:171","msg":"trace[2022661359] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:561; }","duration":"1.140117137s","start":"2026-02-10T14:58:46.04524Z","end":"2026-02-10T14:58:47.185357Z","steps":["trace[2022661359] 'agreement among raft nodes before linearized reading' (duration: 1.137655774s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.185475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:46.045225Z","time spent":"1.140240113s","remote":"127.0.0.1:37492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-10T14:58:47.183171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.65957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-10T14:58:47.185878Z","caller":"traceutil/trace.go:171","msg":"trace[2089783504] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:561; }","duration":"736.388453ms","start":"2026-02-10T14:58:46.44948Z","end":"2026-02-10T14:58:47.185868Z","steps":["trace[2089783504] 'agreement among raft nodes before linearized reading' (duration: 733.509484ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.186021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:46.449466Z","time spent":"736.546818ms","remote":"127.0.0.1:37492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5609,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-02-10T14:58:47.183096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.247473285s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:47.186323Z","caller":"traceutil/trace.go:171","msg":"trace[1808368356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"1.250659573s","start":"2026-02-10T14:58:45.935595Z","end":"2026-02-10T14:58:47.186254Z","steps":["trace[1808368356] 'agreement among raft nodes before linearized reading' (duration: 1.247483614s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.18638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:45.935582Z","time spent":"1.250790019s","remote":"127.0.0.1:37436","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-10T14:58:47.183397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.282327523s","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-10T14:58:47.186911Z","caller":"traceutil/trace.go:171","msg":"trace[534255906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:561; }","duration":"1.285919275s","start":"2026-02-10T14:58:45.900946Z","end":"2026-02-10T14:58:47.186865Z","steps":["trace[534255906] 'agreement among raft nodes before linearized reading' (duration: 1.282286844s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.186944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:45.900939Z","time spent":"1.285997602s","remote":"127.0.0.1:37706","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-10T14:58:47.183511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.284268619s","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-10T14:58:47.187268Z","caller":"traceutil/trace.go:171","msg":"trace[607538554] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"1.288046615s","start":"2026-02-10T14:58:45.899213Z","end":"2026-02-10T14:58:47.18726Z","steps":["trace[607538554] 'agreement among raft nodes before linearized reading' (duration: 1.284207181s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:47.18733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:45.899188Z","time spent":"1.288134032s","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-10T14:58:51.438557Z","caller":"traceutil/trace.go:171","msg":"trace[2060800339] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"192.408605ms","start":"2026-02-10T14:58:51.246107Z","end":"2026-02-10T14:58:51.438516Z","steps":["trace[2060800339] 'process raft request' (duration: 192.083424ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:51.442955Z","caller":"traceutil/trace.go:171","msg":"trace[477930960] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"196.615748ms","start":"2026-02-10T14:58:51.246322Z","end":"2026-02-10T14:58:51.442938Z","steps":["trace[477930960] 'process raft request' (duration: 196.469483ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:51.444012Z","caller":"traceutil/trace.go:171","msg":"trace[800843197] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:622; }","duration":"187.307129ms","start":"2026-02-10T14:58:51.25669Z","end":"2026-02-10T14:58:51.443997Z","steps":["trace[800843197] 'read index received' (duration: 187.298959ms)","trace[800843197] 'applied index is now lower than readState.Index' (duration: 4.7µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:51.445341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.635449ms","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-10T14:58:51.44541Z","caller":"traceutil/trace.go:171","msg":"trace[1054957239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"188.744715ms","start":"2026-02-10T14:58:51.256657Z","end":"2026-02-10T14:58:51.445402Z","steps":["trace[1054957239] 'agreement among raft nodes before linearized reading' (duration: 188.547981ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:51.445711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.62328ms","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":"info","ts":"2026-02-10T14:58:51.44585Z","caller":"traceutil/trace.go:171","msg":"trace[876373671] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:604; }","duration":"184.762845ms","start":"2026-02-10T14:58:51.26107Z","end":"2026-02-10T14:58:51.445833Z","steps":["trace[876373671] 'agreement among raft nodes before linearized reading' (duration: 184.504853ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:51.446039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.987357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:51.460337Z","caller":"traceutil/trace.go:171","msg":"trace[445134399] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:604; }","duration":"129.274086ms","start":"2026-02-10T14:58:51.331036Z","end":"2026-02-10T14:58:51.46031Z","steps":["trace[445134399] 'agreement among raft nodes before linearized reading' (duration: 114.988506ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:51.446062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.042585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:51.460571Z","caller":"traceutil/trace.go:171","msg":"trace[968286327] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:604; }","duration":"129.589287ms","start":"2026-02-10T14:58:51.330976Z","end":"2026-02-10T14:58:51.460565Z","steps":["trace[968286327] 'agreement among raft nodes before linearized reading' (duration: 115.075654ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:51.446077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.107473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:51.460642Z","caller":"traceutil/trace.go:171","msg":"trace[1784767315] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:604; }","duration":"129.691105ms","start":"2026-02-10T14:58:51.330947Z","end":"2026-02-10T14:58:51.460638Z","steps":["trace[1784767315] 'agreement among raft nodes before linearized reading' (duration: 115.121803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:51.4461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.822551ms","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-10T14:58:51.460736Z","caller":"traceutil/trace.go:171","msg":"trace[1267656433] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:604; }","duration":"135.462951ms","start":"2026-02-10T14:58:51.325269Z","end":"2026-02-10T14:58:51.460731Z","steps":["trace[1267656433] 'agreement among raft nodes before linearized reading' (duration: 120.814821ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:51.446115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.85024ms","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-10T14:58:51.460862Z","caller":"traceutil/trace.go:171","msg":"trace[64385721] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:604; }","duration":"135.605916ms","start":"2026-02-10T14:58:51.325251Z","end":"2026-02-10T14:58:51.460857Z","steps":["trace[64385721] 'agreement among raft nodes before linearized reading' (duration: 120.85577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:51.44613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.896019ms","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-10T14:58:51.460941Z","caller":"traceutil/trace.go:171","msg":"trace[880514533] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:604; }","duration":"135.707063ms","start":"2026-02-10T14:58:51.325216Z","end":"2026-02-10T14:58:51.460923Z","steps":["trace[880514533] 'agreement among raft nodes before linearized reading' (duration: 120.906688ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:51.446163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.640619ms","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-10T14:58:51.461008Z","caller":"traceutil/trace.go:171","msg":"trace[15325478] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"196.492483ms","start":"2026-02-10T14:58:51.264511Z","end":"2026-02-10T14:58:51.461003Z","steps":["trace[15325478] 'agreement among raft nodes before linearized reading' (duration: 181.62647ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:51.44816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.094875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:51.461098Z","caller":"traceutil/trace.go:171","msg":"trace[1683625040] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:604; }","duration":"114.043985ms","start":"2026-02-10T14:58:51.34705Z","end":"2026-02-10T14:58:51.461094Z","steps":["trace[1683625040] 'agreement among raft nodes before linearized reading' (duration: 101.089735ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:51.450258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.171322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:51.461189Z","caller":"traceutil/trace.go:171","msg":"trace[988736974] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:604; }","duration":"114.147782ms","start":"2026-02-10T14:58:51.347037Z","end":"2026-02-10T14:58:51.461185Z","steps":["trace[988736974] 'agreement among raft nodes before linearized reading' (duration: 103.151553ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:53.7122Z","caller":"traceutil/trace.go:171","msg":"trace[1550608590] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"236.750132ms","start":"2026-02-10T14:58:53.47543Z","end":"2026-02-10T14:58:53.712181Z","steps":["trace[1550608590] 'process raft request' (duration: 236.575157ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:54.20045Z","caller":"traceutil/trace.go:171","msg":"trace[1778492601] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"708.723586ms","start":"2026-02-10T14:58:53.491709Z","end":"2026-02-10T14:58:54.200432Z","steps":["trace[1778492601] 'read index received' (duration: 220.498089ms)","trace[1778492601] 'applied index is now lower than readState.Index' (duration: 488.224857ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:58:54.200536Z","caller":"traceutil/trace.go:171","msg":"trace[213209488] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"724.096773ms","start":"2026-02-10T14:58:53.47643Z","end":"2026-02-10T14:58:54.200527Z","steps":["trace[213209488] 'process raft request' (duration: 630.535116ms)","trace[213209488] 'compare' (duration: 93.218935ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:54.200603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:53.476406Z","time spent":"724.147031ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:58:54.20063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.900011ms","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":"info","ts":"2026-02-10T14:58:54.200684Z","caller":"traceutil/trace.go:171","msg":"trace[1747994952] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:609; }","duration":"708.972409ms","start":"2026-02-10T14:58:53.491698Z","end":"2026-02-10T14:58:54.20067Z","steps":["trace[1747994952] 'agreement among raft nodes before linearized reading' (duration: 708.831223ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:54.200711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:53.491695Z","time spent":"709.010568ms","remote":"127.0.0.1:37706","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-10T14:58:54.249097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.699938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.18\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-10T14:58:54.249148Z","caller":"traceutil/trace.go:171","msg":"trace[1728305164] range","detail":"{range_begin:/registry/masterleases/199.19.213.18; range_end:; response_count:1; response_revision:610; }","duration":"228.782267ms","start":"2026-02-10T14:58:54.020354Z","end":"2026-02-10T14:58:54.249136Z","steps":["trace[1728305164] 'agreement among raft nodes before linearized reading' (duration: 228.604531ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:54.250172Z","caller":"traceutil/trace.go:171","msg":"trace[923828493] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"514.59139ms","start":"2026-02-10T14:58:53.735573Z","end":"2026-02-10T14:58:54.250164Z","steps":["trace[923828493] 'process raft request' (duration: 513.186168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:54.250232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:53.735555Z","time spent":"514.637428ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:58:54.250455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.937441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:54.250472Z","caller":"traceutil/trace.go:171","msg":"trace[2089823755] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"316.97658ms","start":"2026-02-10T14:58:53.933491Z","end":"2026-02-10T14:58:54.250467Z","steps":["trace[2089823755] 'agreement among raft nodes before linearized reading' (duration: 316.947611ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:54.250485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:53.933477Z","time spent":"317.005359ms","remote":"127.0.0.1:37436","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-10T14:58:54.250615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.866724ms","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-10T14:58:54.250629Z","caller":"traceutil/trace.go:171","msg":"trace[1003969004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:610; }","duration":"758.984171ms","start":"2026-02-10T14:58:53.49164Z","end":"2026-02-10T14:58:54.250624Z","steps":["trace[1003969004] 'agreement among raft nodes before linearized reading' (duration: 758.940542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:54.250641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:53.491626Z","time spent":"759.011781ms","remote":"127.0.0.1:37706","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-10T14:58:54.251523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.781001ms","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-10T14:58:54.251604Z","caller":"traceutil/trace.go:171","msg":"trace[2144238004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"759.869229ms","start":"2026-02-10T14:58:53.491727Z","end":"2026-02-10T14:58:54.251596Z","steps":["trace[2144238004] 'agreement among raft nodes before linearized reading' (duration: 757.204389ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:54.253358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:53.491724Z","time spent":"761.623792ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-10T14:58:54.353401Z","caller":"traceutil/trace.go:171","msg":"trace[1530879032] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"147.952565ms","start":"2026-02-10T14:58:54.205434Z","end":"2026-02-10T14:58:54.353387Z","steps":["trace[1530879032] 'process raft request' (duration: 109.168445ms)","trace[1530879032] 'compare' (duration: 37.841875ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:55.436867Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700300478993928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:58:55.93935Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700300478993928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:58:56.390023Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.512275428s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T14:58:56.39041Z","caller":"traceutil/trace.go:171","msg":"trace[1726705712] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"1.454592509s","start":"2026-02-10T14:58:54.935791Z","end":"2026-02-10T14:58:56.390383Z","steps":["trace[1726705712] 'read index received' (duration: 1.454313615s)","trace[1726705712] 'applied index is now lower than readState.Index' (duration: 277.974µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:58:56.390535Z","caller":"traceutil/trace.go:171","msg":"trace[1258529876] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"1.512924633s","start":"2026-02-10T14:58:54.877601Z","end":"2026-02-10T14:58:56.390526Z","steps":["trace[1258529876] 'process raft request' (duration: 1.512609451s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:56.390628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:54.877583Z","time spent":"1.512979401s","remote":"127.0.0.1:37634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:58:56.390723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.063849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-10T14:58:56.390752Z","caller":"traceutil/trace.go:171","msg":"trace[1538357240] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"675.135678ms","start":"2026-02-10T14:58:55.715607Z","end":"2026-02-10T14:58:56.390743Z","steps":["trace[1538357240] 'agreement among raft nodes before linearized reading' (duration: 675.03703ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:56.390773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:55.715589Z","time spent":"675.180216ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T14:58:56.390868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.455077868s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:56.390882Z","caller":"traceutil/trace.go:171","msg":"trace[1912888410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"1.455112727s","start":"2026-02-10T14:58:54.935763Z","end":"2026-02-10T14:58:56.390876Z","steps":["trace[1912888410] 'agreement among raft nodes before linearized reading' (duration: 1.455093407s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:56.390893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:54.935748Z","time spent":"1.455142305s","remote":"127.0.0.1:37436","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-10T14:58:56.390982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.576465ms","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-10T14:58:56.390996Z","caller":"traceutil/trace.go:171","msg":"trace[62386181] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"185.615214ms","start":"2026-02-10T14:58:56.205375Z","end":"2026-02-10T14:58:56.39099Z","steps":["trace[62386181] 'agreement among raft nodes before linearized reading' (duration: 185.576155ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:57.673171Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.142772272s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-10T14:58:58.432911Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700300478993934,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:58:58.591443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.79927ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:58:58.59151Z","caller":"traceutil/trace.go:171","msg":"trace[454316659] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"2.183284659s","start":"2026-02-10T14:58:56.408215Z","end":"2026-02-10T14:58:58.5915Z","steps":["trace[454316659] 'process raft request' (duration: 1.265319743s)","trace[454316659] 'compare' (duration: 917.399908ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:58.591551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:56.408187Z","time spent":"2.183339537s","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:58:58.933119Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700300478993934,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:58:59.186173Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.512872848s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-10T14:58:59.44247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.950798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:58:59.442876Z","caller":"traceutil/trace.go:171","msg":"trace[1279097850] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"3.032639058s","start":"2026-02-10T14:58:56.410212Z","end":"2026-02-10T14:58:59.442851Z","steps":["trace[1279097850] 'process raft request' (duration: 3.032319535s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:59.443053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:56.410204Z","time spent":"3.032762456s","remote":"127.0.0.1:37706","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-10T14:58:59.443068Z","caller":"traceutil/trace.go:171","msg":"trace[1416318555] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"3.020783752s","start":"2026-02-10T14:58:56.42227Z","end":"2026-02-10T14:58:59.443054Z","steps":["trace[1416318555] 'process raft request' (duration: 3.020292592s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:59.443127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:56.422255Z","time spent":"3.020847181s","remote":"127.0.0.1:37706","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-10T14:58:59.44321Z","caller":"traceutil/trace.go:171","msg":"trace[511778143] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"3.019706669s","start":"2026-02-10T14:58:56.423496Z","end":"2026-02-10T14:58:59.443203Z","steps":["trace[511778143] 'process raft request' (duration: 3.019084802s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:59.443238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:56.42347Z","time spent":"3.019752817s","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:58:59.443287Z","caller":"traceutil/trace.go:171","msg":"trace[13931417] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"2.190464761s","start":"2026-02-10T14:58:57.252817Z","end":"2026-02-10T14:58:59.443282Z","steps":["trace[13931417] 'process raft request' (duration: 2.189782715s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:59.443312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:57.252796Z","time spent":"2.19050254s","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:58:59.443356Z","caller":"traceutil/trace.go:171","msg":"trace[1623533545] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:638; }","duration":"1.510883019s","start":"2026-02-10T14:58:57.932467Z","end":"2026-02-10T14:58:59.44335Z","steps":["trace[1623533545] 'read index received' (duration: 1.25399934s)","trace[1623533545] 'applied index is now lower than readState.Index' (duration: 256.883089ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:58:59.4434Z","caller":"traceutil/trace.go:171","msg":"trace[1215280979] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"3.03510755s","start":"2026-02-10T14:58:56.408282Z","end":"2026-02-10T14:58:59.44339Z","steps":["trace[1215280979] 'process raft request' (duration: 2.778175332s)","trace[1215280979] 'compare' (duration: 255.665014ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:59.443444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:56.408272Z","time spent":"3.035149749s","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:58:59.580903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.23233ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-10T14:58:59.580985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.648515981s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:59.581012Z","caller":"traceutil/trace.go:171","msg":"trace[1002990812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"1.648540791s","start":"2026-02-10T14:58:57.932458Z","end":"2026-02-10T14:58:59.580999Z","steps":["trace[1002990812] 'agreement among raft nodes before linearized reading' (duration: 1.510913158s)","trace[1002990812] 'range keys from in-memory index tree' (duration: 137.592963ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:59.581039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:57.932424Z","time spent":"1.648609889s","remote":"127.0.0.1:37436","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-10T14:59:02.0913Z","caller":"traceutil/trace.go:171","msg":"trace[1077755942] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"100.053011ms","start":"2026-02-10T14:59:01.991226Z","end":"2026-02-10T14:59:02.091279Z","steps":["trace[1077755942] 'process raft request' (duration: 99.862804ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:59:04.577617Z","caller":"traceutil/trace.go:171","msg":"trace[1304080948] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"276.18272ms","start":"2026-02-10T14:59:04.301407Z","end":"2026-02-10T14:59:04.57759Z","steps":["trace[1304080948] 'process raft request' (duration: 275.981563ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:59:31.82174Z","caller":"traceutil/trace.go:171","msg":"trace[1871922150] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"102.262924ms","start":"2026-02-10T14:59:31.719382Z","end":"2026-02-10T14:59:31.821645Z","steps":["trace[1871922150] 'process raft request' (duration: 42.988914ms)","trace[1871922150] 'compare' (duration: 58.844806ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T15:00:26.427744Z","caller":"traceutil/trace.go:171","msg":"trace[537455177] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"192.202336ms","start":"2026-02-10T15:00:26.235522Z","end":"2026-02-10T15:00:26.427725Z","steps":["trace[537455177] 'process raft request' (duration: 126.408396ms)","trace[537455177] 'compare' (duration: 65.492529ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T15:00:34.33914Z","caller":"traceutil/trace.go:171","msg":"trace[1258180539] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"124.237364ms","start":"2026-02-10T15:00:34.214868Z","end":"2026-02-10T15:00:34.339106Z","steps":["trace[1258180539] 'process raft request' (duration: 96.17184ms)","trace[1258180539] 'compare' (duration: 27.746653ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T15:00:38.474612Z","caller":"traceutil/trace.go:171","msg":"trace[1682305461] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"119.665057ms","start":"2026-02-10T15:00:38.354926Z","end":"2026-02-10T15:00:38.474591Z","steps":["trace[1682305461] 'process raft request' (duration: 119.137718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T15:00:42.972389Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700300478995027,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T15:00:43.472686Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700300478995027,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T15:00:43.67028Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.357981767s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T15:00:43.67083Z","caller":"traceutil/trace.go:171","msg":"trace[1500539644] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"1.199363059s","start":"2026-02-10T15:00:42.471417Z","end":"2026-02-10T15:00:43.67078Z","steps":["trace[1500539644] 'read index received' (duration: 1.199069678s)","trace[1500539644] 'applied index is now lower than readState.Index' (duration: 291.541µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T15:00:43.671292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184407855s","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-10T15:00:43.671363Z","caller":"traceutil/trace.go:171","msg":"trace[1706432406] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1059; }","duration":"1.184529439s","start":"2026-02-10T15:00:42.486814Z","end":"2026-02-10T15:00:43.671344Z","steps":["trace[1706432406] 'agreement among raft nodes before linearized reading' (duration: 1.184336442s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T15:00:43.671437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T15:00:42.486801Z","time spent":"1.184622213s","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-10T15:00:43.671629Z","caller":"traceutil/trace.go:171","msg":"trace[996202085] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"1.359424203s","start":"2026-02-10T15:00:42.312187Z","end":"2026-02-10T15:00:43.671612Z","steps":["trace[996202085] 'process raft request' (duration: 1.358363942s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T15:00:43.671749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T15:00:42.312169Z","time spent":"1.359509075s","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T15:00:43.671901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.200492273s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T15:00:43.671957Z","caller":"traceutil/trace.go:171","msg":"trace[419611883] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1059; }","duration":"1.200577836s","start":"2026-02-10T15:00:42.471363Z","end":"2026-02-10T15:00:43.67194Z","steps":["trace[419611883] 'agreement among raft nodes before linearized reading' (duration: 1.200493543s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T15:00:43.672005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T15:00:42.471293Z","time spent":"1.20069855s","remote":"127.0.0.1:37862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-10T15:00:43.672303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.702891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-10T15:00:43.672356Z","caller":"traceutil/trace.go:171","msg":"trace[1586984282] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1059; }","duration":"400.777003ms","start":"2026-02-10T15:00:43.271565Z","end":"2026-02-10T15:00:43.672342Z","steps":["trace[1586984282] 'agreement among raft nodes before linearized reading' (duration: 400.647888ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T15:00:43.672399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T15:00:43.271552Z","time spent":"400.833056ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T15:00:43.673086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.202852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T15:00:43.673144Z","caller":"traceutil/trace.go:171","msg":"trace[53670008] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1059; }","duration":"548.291966ms","start":"2026-02-10T15:00:43.124837Z","end":"2026-02-10T15:00:43.673129Z","steps":["trace[53670008] 'agreement among raft nodes before linearized reading' (duration: 548.201802ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T15:00:43.673349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T15:00:43.124824Z","time spent":"548.504444ms","remote":"127.0.0.1:58220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-02-10T15:00:43.67389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.514457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T15:00:43.673953Z","caller":"traceutil/trace.go:171","msg":"trace[1157524463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"740.60606ms","start":"2026-02-10T15:00:42.933329Z","end":"2026-02-10T15:00:43.673935Z","steps":["trace[1157524463] 'agreement among raft nodes before linearized reading' (duration: 740.519787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T15:00:43.674193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T15:00:42.933287Z","time spent":"740.855069ms","remote":"127.0.0.1:37436","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-10T15:00:43.674728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.064070951s","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-10T15:00:43.674791Z","caller":"traceutil/trace.go:171","msg":"trace[2039301675] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1059; }","duration":"1.064227956s","start":"2026-02-10T15:00:42.610548Z","end":"2026-02-10T15:00:43.674776Z","steps":["trace[2039301675] 'agreement among raft nodes before linearized reading' (duration: 1.064022129s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T15:00:43.674998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T15:00:42.610533Z","time spent":"1.064427034s","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-10T15:00:43.675335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185407554s","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-10T15:00:43.675372Z","caller":"traceutil/trace.go:171","msg":"trace[2012461153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1059; }","duration":"1.185466376s","start":"2026-02-10T15:00:42.489897Z","end":"2026-02-10T15:00:43.675363Z","steps":["trace[2012461153] 'agreement among raft nodes before linearized reading' (duration: 1.185377733s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T15:00:43.675606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T15:00:42.489886Z","time spent":"1.185709125s","remote":"127.0.0.1:37706","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\" "}