{"level":"warn","ts":"2026-02-13T00:38:47.421724Z","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-13T00:38:47.421923Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-13T00:38:47.422239Z","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-13T00:38:47.422313Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-02-13T00:38:47.423145Z","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-13T00:38:47.433994Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-02-13T00:38:47.434139Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-13T00:38:47.438841Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.508633ms"} {"level":"info","ts":"2026-02-13T00:38:47.462482Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-02-13T00:38:47.462579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-02-13T00:38:47.462604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-02-13T00:38:47.462684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-13T00:38:47.462692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-02-13T00:38:47.462764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-02-13T00:38:47.473249Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-13T00:38:47.480841Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-13T00:38:47.484921Z","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-13T00:38:47.496405Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-13T00:38:47.511295Z","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-13T00:38:47.511511Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-13T00:38:47.511537Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-13T00:38:47.51165Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-02-13T00:38:47.511661Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-02-13T00:38:47.518965Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-13T00:38:47.519121Z","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-13T00:38:47.519149Z","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-13T00:38:47.519157Z","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-13T00:38:47.519418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-02-13T00:38:47.519531Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-02-13T00:38:48.265035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-02-13T00:38:48.265125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-13T00:38:48.26515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-02-13T00:38:48.265172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-02-13T00:38:48.26522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-02-13T00:38:48.265245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-02-13T00:38:48.265262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-02-13T00:38:48.366864Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-02-13T00:38:48.371087Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T00:38:48.371179Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T00:38:48.371435Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-13T00:38:48.37148Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-13T00:38:48.371534Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T00:38:48.376813Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-02-13T00:38:48.376995Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-13T00:38:48.377839Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T00:38:48.378662Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T00:38:48.378688Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T00:38:54.595698Z","caller":"traceutil/trace.go:171","msg":"trace[1378115290] linearizableReadLoop","detail":"{readStateIndex:281; appliedIndex:277; }","duration":"115.89984ms","start":"2026-02-13T00:38:54.479783Z","end":"2026-02-13T00:38:54.595682Z","steps":["trace[1378115290] 'read index received' (duration: 42.400377ms)","trace[1378115290] 'applied index is now lower than readState.Index' (duration: 73.498883ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:38:54.595688Z","caller":"traceutil/trace.go:171","msg":"trace[759752699] transaction","detail":"{read_only:false; number_of_response:0; response_revision:269; }","duration":"147.552791ms","start":"2026-02-13T00:38:54.448107Z","end":"2026-02-13T00:38:54.59566Z","steps":["trace[759752699] 'process raft request' (duration: 147.424369ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:54.595791Z","caller":"traceutil/trace.go:171","msg":"trace[1339830437] transaction","detail":"{read_only:false; number_of_response:0; response_revision:269; }","duration":"146.758383ms","start":"2026-02-13T00:38:54.449027Z","end":"2026-02-13T00:38:54.595786Z","steps":["trace[1339830437] 'process raft request' (duration: 146.549211ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:54.595881Z","caller":"traceutil/trace.go:171","msg":"trace[1114392796] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"135.43549ms","start":"2026-02-13T00:38:54.460435Z","end":"2026-02-13T00:38:54.59587Z","steps":["trace[1114392796] 'process raft request' (duration: 135.186567ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:54.595985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.167203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-13T00:38:54.596016Z","caller":"traceutil/trace.go:171","msg":"trace[1290910554] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:270; }","duration":"116.254913ms","start":"2026-02-13T00:38:54.479755Z","end":"2026-02-13T00:38:54.59601Z","steps":["trace[1290910554] 'agreement among raft nodes before linearized reading' (duration: 116.164832ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:54.596048Z","caller":"traceutil/trace.go:171","msg":"trace[1649402857] transaction","detail":"{read_only:false; number_of_response:0; response_revision:269; }","duration":"146.886454ms","start":"2026-02-13T00:38:54.449153Z","end":"2026-02-13T00:38:54.596039Z","steps":["trace[1649402857] 'process raft request' (duration: 146.448069ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:54.879382Z","caller":"traceutil/trace.go:171","msg":"trace[101714137] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"194.524388ms","start":"2026-02-13T00:38:54.684834Z","end":"2026-02-13T00:38:54.879358Z","steps":["trace[101714137] 'process raft request' (duration: 194.478977ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:54.879447Z","caller":"traceutil/trace.go:171","msg":"trace[850564285] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"209.60938ms","start":"2026-02-13T00:38:54.669807Z","end":"2026-02-13T00:38:54.879416Z","steps":["trace[850564285] 'process raft request' (duration: 127.462545ms)","trace[850564285] 'compare' (duration: 81.924083ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:38:55.093017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.405333ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T00:38:55.095166Z","caller":"traceutil/trace.go:171","msg":"trace[1813870854] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"204.674246ms","start":"2026-02-13T00:38:54.890475Z","end":"2026-02-13T00:38:55.095149Z","steps":["trace[1813870854] 'process raft request' (duration: 100.604745ms)","trace[1813870854] 'compare' (duration: 101.312592ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:38:55.093115Z","caller":"traceutil/trace.go:171","msg":"trace[1411903393] linearizableReadLoop","detail":"{readStateIndex:286; appliedIndex:285; }","duration":"202.581304ms","start":"2026-02-13T00:38:54.890517Z","end":"2026-02-13T00:38:55.093098Z","steps":["trace[1411903393] 'read index received' (duration: 100.592305ms)","trace[1411903393] 'applied index is now lower than readState.Index' (duration: 101.987949ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:38:55.095713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.181591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-13T00:38:55.095749Z","caller":"traceutil/trace.go:171","msg":"trace[1360937406] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:275; }","duration":"205.240462ms","start":"2026-02-13T00:38:54.890497Z","end":"2026-02-13T00:38:55.095738Z","steps":["trace[1360937406] 'agreement among raft nodes before linearized reading' (duration: 205.150741ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:56.183829Z","caller":"traceutil/trace.go:171","msg":"trace[1542583424] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"251.868105ms","start":"2026-02-13T00:38:55.931717Z","end":"2026-02-13T00:38:56.183585Z","steps":["trace[1542583424] 'process raft request' (duration: 251.737123ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:56.346593Z","caller":"traceutil/trace.go:171","msg":"trace[1290431206] linearizableReadLoop","detail":"{readStateIndex:298; appliedIndex:297; }","duration":"153.293867ms","start":"2026-02-13T00:38:56.193274Z","end":"2026-02-13T00:38:56.346567Z","steps":["trace[1290431206] 'read index received' (duration: 135.638911ms)","trace[1290431206] 'applied index is now lower than readState.Index' (duration: 17.653916ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:38:56.346894Z","caller":"traceutil/trace.go:171","msg":"trace[1844410069] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"156.128506ms","start":"2026-02-13T00:38:56.190751Z","end":"2026-02-13T00:38:56.346879Z","steps":["trace[1844410069] 'process raft request' (duration: 138.196637ms)","trace[1844410069] 'compare' (duration: 17.497805ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:38:56.347384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.088595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-13T00:38:56.347423Z","caller":"traceutil/trace.go:171","msg":"trace[1969206400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:287; }","duration":"154.151816ms","start":"2026-02-13T00:38:56.193259Z","end":"2026-02-13T00:38:56.347411Z","steps":["trace[1969206400] 'agreement among raft nodes before linearized reading' (duration: 153.847553ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:56.347614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.020893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-13T00:38:56.347639Z","caller":"traceutil/trace.go:171","msg":"trace[1889848251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:287; }","duration":"152.058373ms","start":"2026-02-13T00:38:56.195573Z","end":"2026-02-13T00:38:56.347632Z","steps":["trace[1889848251] 'agreement among raft nodes before linearized reading' (duration: 152.014833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:56.347729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.727186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-13T00:38:56.347871Z","caller":"traceutil/trace.go:171","msg":"trace[377979499] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:287; }","duration":"125.897508ms","start":"2026-02-13T00:38:56.221957Z","end":"2026-02-13T00:38:56.347854Z","steps":["trace[377979499] 'agreement among raft nodes before linearized reading' (duration: 125.713876ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:56.600703Z","caller":"traceutil/trace.go:171","msg":"trace[1937627900] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"173.905184ms","start":"2026-02-13T00:38:56.426777Z","end":"2026-02-13T00:38:56.600682Z","steps":["trace[1937627900] 'process raft request' (duration: 140.600033ms)","trace[1937627900] 'compare' (duration: 33.18445ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:38:57.076758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.276547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-13T00:38:57.076944Z","caller":"traceutil/trace.go:171","msg":"trace[1891162944] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"468.712895ms","start":"2026-02-13T00:38:56.608212Z","end":"2026-02-13T00:38:57.076924Z","steps":["trace[1891162944] 'process raft request' (duration: 153.202646ms)","trace[1891162944] 'compare' (duration: 315.148875ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:38:57.077072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:56.608203Z","time spent":"468.838296ms","remote":"127.0.0.1:41094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":190,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:38:57.244002Z","caller":"traceutil/trace.go:171","msg":"trace[905478652] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"148.335378ms","start":"2026-02-13T00:38:57.095519Z","end":"2026-02-13T00:38:57.243854Z","steps":["trace[905478652] 'process raft request' (duration: 115.319403ms)","trace[905478652] 'compare' (duration: 32.844013ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:38:57.467294Z","caller":"traceutil/trace.go:171","msg":"trace[1337324377] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"158.277492ms","start":"2026-02-13T00:38:57.308999Z","end":"2026-02-13T00:38:57.467276Z","steps":["trace[1337324377] 'process raft request' (duration: 69.404514ms)","trace[1337324377] 'compare' (duration: 88.792807ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:38:57.657058Z","caller":"traceutil/trace.go:171","msg":"trace[1826818343] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"166.325564ms","start":"2026-02-13T00:38:57.490703Z","end":"2026-02-13T00:38:57.657028Z","steps":["trace[1826818343] 'process raft request' (duration: 77.74542ms)","trace[1826818343] 'compare' (duration: 88.268471ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:38:58.648699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.73959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T00:38:58.649313Z","caller":"traceutil/trace.go:171","msg":"trace[1260558959] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"267.670213ms","start":"2026-02-13T00:38:58.381613Z","end":"2026-02-13T00:38:58.649283Z","steps":["trace[1260558959] 'process raft request' (duration: 163.267316ms)","trace[1260558959] 'compare' (duration: 103.589109ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:38:58.649616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.196715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-13T00:38:58.649657Z","caller":"traceutil/trace.go:171","msg":"trace[1912529030] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:307; }","duration":"255.245805ms","start":"2026-02-13T00:38:58.3944Z","end":"2026-02-13T00:38:58.649646Z","steps":["trace[1912529030] 'agreement among raft nodes before linearized reading' (duration: 255.174994ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:58.651084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.6793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-13T00:38:58.651137Z","caller":"traceutil/trace.go:171","msg":"trace[518309494] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:307; }","duration":"256.73625ms","start":"2026-02-13T00:38:58.39439Z","end":"2026-02-13T00:38:58.651126Z","steps":["trace[518309494] 'agreement among raft nodes before linearized reading' (duration: 256.647099ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:58.651772Z","caller":"traceutil/trace.go:171","msg":"trace[410957716] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:317; }","duration":"226.101144ms","start":"2026-02-13T00:38:58.423138Z","end":"2026-02-13T00:38:58.649239Z","steps":["trace[410957716] 'read index received' (duration: 121.670476ms)","trace[410957716] 'applied index is now lower than readState.Index' (duration: 104.429388ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:38:58.65199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.503736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-02-13T00:38:58.652068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.852938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7237"} {"level":"info","ts":"2026-02-13T00:38:58.652127Z","caller":"traceutil/trace.go:171","msg":"trace[1829698034] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:307; }","duration":"213.922809ms","start":"2026-02-13T00:38:58.438193Z","end":"2026-02-13T00:38:58.652116Z","steps":["trace[1829698034] 'agreement among raft nodes before linearized reading' (duration: 213.823158ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:58.652264Z","caller":"traceutil/trace.go:171","msg":"trace[327210604] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:307; }","duration":"220.655377ms","start":"2026-02-13T00:38:58.431448Z","end":"2026-02-13T00:38:58.652104Z","steps":["trace[327210604] 'agreement among raft nodes before linearized reading' (duration: 220.512666ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:58.652622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.886549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5270"} {"level":"warn","ts":"2026-02-13T00:38:58.65285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.107597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-13T00:38:58.65289Z","caller":"traceutil/trace.go:171","msg":"trace[462929507] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:307; }","duration":"172.171427ms","start":"2026-02-13T00:38:58.480706Z","end":"2026-02-13T00:38:58.652877Z","steps":["trace[462929507] 'agreement among raft nodes before linearized reading' (duration: 172.124547ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:58.653245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.413614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-02-13T00:38:58.653268Z","caller":"traceutil/trace.go:171","msg":"trace[445152744] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:307; }","duration":"216.446714ms","start":"2026-02-13T00:38:58.436816Z","end":"2026-02-13T00:38:58.653263Z","steps":["trace[445152744] 'agreement among raft nodes before linearized reading' (duration: 216.408384ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:58.653351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.636776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4597"} {"level":"info","ts":"2026-02-13T00:38:58.653371Z","caller":"traceutil/trace.go:171","msg":"trace[1140150719] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:307; }","duration":"215.663416ms","start":"2026-02-13T00:38:58.437703Z","end":"2026-02-13T00:38:58.653366Z","steps":["trace[1140150719] 'agreement among raft nodes before linearized reading' (duration: 215.629526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:58.653449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.757887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-13T00:38:58.653468Z","caller":"traceutil/trace.go:171","msg":"trace[304577389] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:307; }","duration":"215.786117ms","start":"2026-02-13T00:38:58.437677Z","end":"2026-02-13T00:38:58.653463Z","steps":["trace[304577389] 'agreement among raft nodes before linearized reading' (duration: 215.755197ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:58.653777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.042701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-13T00:38:58.653813Z","caller":"traceutil/trace.go:171","msg":"trace[538311493] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:307; }","duration":"217.090581ms","start":"2026-02-13T00:38:58.436716Z","end":"2026-02-13T00:38:58.653807Z","steps":["trace[538311493] 'agreement among raft nodes before linearized reading' (duration: 217.03697ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:58.654031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.322663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6898"} {"level":"info","ts":"2026-02-13T00:38:58.65406Z","caller":"traceutil/trace.go:171","msg":"trace[889481970] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:307; }","duration":"217.363664ms","start":"2026-02-13T00:38:58.436688Z","end":"2026-02-13T00:38:58.654052Z","steps":["trace[889481970] 'agreement among raft nodes before linearized reading' (duration: 217.318094ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:58.652806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.735108ms","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-13T00:38:58.654385Z","caller":"traceutil/trace.go:171","msg":"trace[860670053] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:307; }","duration":"124.336484ms","start":"2026-02-13T00:38:58.530041Z","end":"2026-02-13T00:38:58.654377Z","steps":["trace[860670053] 'agreement among raft nodes before linearized reading' (duration: 122.733267ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:58.656538Z","caller":"traceutil/trace.go:171","msg":"trace[1520793053] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:307; }","duration":"215.150521ms","start":"2026-02-13T00:38:58.437718Z","end":"2026-02-13T00:38:58.652869Z","steps":["trace[1520793053] 'agreement among raft nodes before linearized reading' (duration: 214.856898ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:58.905053Z","caller":"traceutil/trace.go:171","msg":"trace[345724229] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"163.905332ms","start":"2026-02-13T00:38:58.741121Z","end":"2026-02-13T00:38:58.905026Z","steps":["trace[345724229] 'process raft request' (duration: 150.571075ms)","trace[345724229] 'compare' (duration: 13.159655ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:38:58.993948Z","caller":"traceutil/trace.go:171","msg":"trace[141755246] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"252.518457ms","start":"2026-02-13T00:38:58.74137Z","end":"2026-02-13T00:38:58.993888Z","steps":["trace[141755246] 'process raft request' (duration: 252.292995ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:58.993998Z","caller":"traceutil/trace.go:171","msg":"trace[1571212444] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:325; }","duration":"252.572928ms","start":"2026-02-13T00:38:58.741404Z","end":"2026-02-13T00:38:58.993977Z","steps":["trace[1571212444] 'read index received' (duration: 150.244281ms)","trace[1571212444] 'applied index is now lower than readState.Index' (duration: 102.327807ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:38:58.994657Z","caller":"traceutil/trace.go:171","msg":"trace[1781731588] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"246.276393ms","start":"2026-02-13T00:38:58.748366Z","end":"2026-02-13T00:38:58.994642Z","steps":["trace[1781731588] 'process raft request' (duration: 245.534295ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:58.994891Z","caller":"traceutil/trace.go:171","msg":"trace[917500841] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"249.824249ms","start":"2026-02-13T00:38:58.745052Z","end":"2026-02-13T00:38:58.994876Z","steps":["trace[917500841] 'process raft request' (duration: 248.720598ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:58.995152Z","caller":"traceutil/trace.go:171","msg":"trace[1189605817] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"248.87688ms","start":"2026-02-13T00:38:58.746263Z","end":"2026-02-13T00:38:58.99514Z","steps":["trace[1189605817] 'process raft request' (duration: 247.579687ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:58.995616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.357183ms","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-13T00:38:58.995666Z","caller":"traceutil/trace.go:171","msg":"trace[1802732617] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:319; }","duration":"214.458844ms","start":"2026-02-13T00:38:58.781196Z","end":"2026-02-13T00:38:58.995655Z","steps":["trace[1802732617] 'agreement among raft nodes before linearized reading' (duration: 214.328153ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:59.000474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.057715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-13T00:38:59.000528Z","caller":"traceutil/trace.go:171","msg":"trace[1941567453] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:319; }","duration":"259.117605ms","start":"2026-02-13T00:38:58.741402Z","end":"2026-02-13T00:38:59.00052Z","steps":["trace[1941567453] 'agreement among raft nodes before linearized reading' (duration: 254.372856ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:59.000886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.653202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-13T00:38:59.001136Z","caller":"traceutil/trace.go:171","msg":"trace[2101087074] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:319; }","duration":"169.970565ms","start":"2026-02-13T00:38:58.831153Z","end":"2026-02-13T00:38:59.001124Z","steps":["trace[2101087074] 'agreement among raft nodes before linearized reading' (duration: 169.635981ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:59.001019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.559224ms","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-13T00:38:59.004067Z","caller":"traceutil/trace.go:171","msg":"trace[610819190] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:319; }","duration":"123.546944ms","start":"2026-02-13T00:38:58.880426Z","end":"2026-02-13T00:38:59.003973Z","steps":["trace[610819190] 'agreement among raft nodes before linearized reading' (duration: 120.562814ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:59.36842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.53897ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-13T00:38:59.368778Z","caller":"traceutil/trace.go:171","msg":"trace[873091940] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"368.452415ms","start":"2026-02-13T00:38:59.000286Z","end":"2026-02-13T00:38:59.368739Z","steps":["trace[873091940] 'process raft request' (duration: 67.51261ms)","trace[873091940] 'compare' (duration: 300.242637ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:38:59.368819Z","caller":"traceutil/trace.go:171","msg":"trace[1242146597] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:330; }","duration":"348.290799ms","start":"2026-02-13T00:38:59.020512Z","end":"2026-02-13T00:38:59.368802Z","steps":["trace[1242146597] 'read index received' (duration: 47.370155ms)","trace[1242146597] 'applied index is now lower than readState.Index' (duration: 300.919704ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:38:59.368906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.40005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-02-13T00:38:59.368921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.000267Z","time spent":"368.586616ms","remote":"127.0.0.1:41094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:38:59.369058Z","caller":"traceutil/trace.go:171","msg":"trace[757503002] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"355.701175ms","start":"2026-02-13T00:38:59.013349Z","end":"2026-02-13T00:38:59.36905Z","steps":["trace[757503002] 'process raft request' (duration: 355.25457ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:59.369104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.013333Z","time spent":"355.744645ms","remote":"127.0.0.1:41002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T00:38:59.368931Z","caller":"traceutil/trace.go:171","msg":"trace[730289511] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:325; }","duration":"348.43212ms","start":"2026-02-13T00:38:59.020491Z","end":"2026-02-13T00:38:59.368923Z","steps":["trace[730289511] 'agreement among raft nodes before linearized reading' (duration: 348.36265ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:38:59.369256Z","caller":"traceutil/trace.go:171","msg":"trace[1149985328] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"348.941276ms","start":"2026-02-13T00:38:59.020308Z","end":"2026-02-13T00:38:59.369249Z","steps":["trace[1149985328] 'process raft request' (duration: 348.35929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:59.369253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.02045Z","time spent":"348.787954ms","remote":"127.0.0.1:41094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-02-13T00:38:59.369288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.020284Z","time spent":"348.989636ms","remote":"127.0.0.1:41378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2125,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:38:59.369365Z","caller":"traceutil/trace.go:171","msg":"trace[1133269837] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"348.880865ms","start":"2026-02-13T00:38:59.020478Z","end":"2026-02-13T00:38:59.369359Z","steps":["trace[1133269837] 'process raft request' (duration: 348.218588ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:59.369391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.02047Z","time spent":"348.907115ms","remote":"127.0.0.1:41002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:38:59.369511Z","caller":"traceutil/trace.go:171","msg":"trace[2139187350] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"348.971755ms","start":"2026-02-13T00:38:59.020533Z","end":"2026-02-13T00:38:59.369505Z","steps":["trace[2139187350] 'process raft request' (duration: 348.199128ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:59.369543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.02053Z","time spent":"348.995276ms","remote":"127.0.0.1:41344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3980,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T00:38:59.369674Z","caller":"traceutil/trace.go:171","msg":"trace[1880672405] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"348.494961ms","start":"2026-02-13T00:38:59.021166Z","end":"2026-02-13T00:38:59.369661Z","steps":["trace[1880672405] 'process raft request' (duration: 347.600092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:38:59.369735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.021161Z","time spent":"348.540021ms","remote":"127.0.0.1:41242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T00:39:00.034186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.9123ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-13T00:39:00.034259Z","caller":"traceutil/trace.go:171","msg":"trace[1620704744] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"654.423083ms","start":"2026-02-13T00:38:59.37982Z","end":"2026-02-13T00:39:00.034243Z","steps":["trace[1620704744] 'process raft request' (duration: 358.404432ms)","trace[1620704744] 'compare' (duration: 295.462195ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:39:00.034292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.379803Z","time spent":"654.476473ms","remote":"127.0.0.1:41086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3355,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:39:00.045892Z","caller":"traceutil/trace.go:171","msg":"trace[692721911] linearizableReadLoop","detail":"{readStateIndex:340; appliedIndex:336; }","duration":"377.803535ms","start":"2026-02-13T00:38:59.668077Z","end":"2026-02-13T00:39:00.04588Z","steps":["trace[692721911] 'read index received' (duration: 70.104816ms)","trace[692721911] 'applied index is now lower than readState.Index' (duration: 307.698199ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:39:00.046117Z","caller":"traceutil/trace.go:171","msg":"trace[162866455] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"665.03518ms","start":"2026-02-13T00:38:59.381074Z","end":"2026-02-13T00:39:00.04611Z","steps":["trace[162866455] 'process raft request' (duration: 664.703916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:00.046656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.381069Z","time spent":"665.556645ms","remote":"127.0.0.1:41002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:39:00.046933Z","caller":"traceutil/trace.go:171","msg":"trace[459939611] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"665.694317ms","start":"2026-02-13T00:38:59.381231Z","end":"2026-02-13T00:39:00.046925Z","steps":["trace[459939611] 'process raft request' (duration: 664.597646ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:00.047024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.381226Z","time spent":"665.780518ms","remote":"127.0.0.1:41094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:39:00.047271Z","caller":"traceutil/trace.go:171","msg":"trace[2049852094] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"663.201041ms","start":"2026-02-13T00:38:59.38406Z","end":"2026-02-13T00:39:00.047261Z","steps":["trace[2049852094] 'process raft request' (duration: 661.790247ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:00.048793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.709905ms","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-13T00:39:00.049823Z","caller":"traceutil/trace.go:171","msg":"trace[1056613912] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:329; }","duration":"381.782675ms","start":"2026-02-13T00:38:59.668031Z","end":"2026-02-13T00:39:00.049813Z","steps":["trace[1056613912] 'agreement among raft nodes before linearized reading' (duration: 380.696054ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:00.049973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.668016Z","time spent":"381.946778ms","remote":"127.0.0.1:41146","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-13T00:39:00.047371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:38:59.384055Z","time spent":"663.298592ms","remote":"127.0.0.1:41086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3505,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:39:00.302016Z","caller":"traceutil/trace.go:171","msg":"trace[1297737863] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"217.124886ms","start":"2026-02-13T00:39:00.084869Z","end":"2026-02-13T00:39:00.301994Z","steps":["trace[1297737863] 'process raft request' (duration: 217.089325ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:00.302047Z","caller":"traceutil/trace.go:171","msg":"trace[123272109] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"252.299342ms","start":"2026-02-13T00:39:00.049714Z","end":"2026-02-13T00:39:00.302014Z","steps":["trace[123272109] 'process raft request' (duration: 210.53171ms)","trace[123272109] 'compare' (duration: 41.199226ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:39:00.302252Z","caller":"traceutil/trace.go:171","msg":"trace[1399573496] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"240.019928ms","start":"2026-02-13T00:39:00.062217Z","end":"2026-02-13T00:39:00.302237Z","steps":["trace[1399573496] 'process raft request' (duration: 239.594154ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:00.302325Z","caller":"traceutil/trace.go:171","msg":"trace[1635066380] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"226.009966ms","start":"2026-02-13T00:39:00.076305Z","end":"2026-02-13T00:39:00.302315Z","steps":["trace[1635066380] 'process raft request' (duration: 225.533741ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:00.302402Z","caller":"traceutil/trace.go:171","msg":"trace[290348096] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"226.048556ms","start":"2026-02-13T00:39:00.076346Z","end":"2026-02-13T00:39:00.302395Z","steps":["trace[290348096] 'process raft request' (duration: 225.542891ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:00.302488Z","caller":"traceutil/trace.go:171","msg":"trace[112212419] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"249.050969ms","start":"2026-02-13T00:39:00.053424Z","end":"2026-02-13T00:39:00.302475Z","steps":["trace[112212419] 'process raft request' (duration: 248.248921ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:00.302642Z","caller":"traceutil/trace.go:171","msg":"trace[1210042320] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"226.157297ms","start":"2026-02-13T00:39:00.076472Z","end":"2026-02-13T00:39:00.30263Z","steps":["trace[1210042320] 'process raft request' (duration: 225.4477ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:00.302717Z","caller":"traceutil/trace.go:171","msg":"trace[185561503] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"249.243041ms","start":"2026-02-13T00:39:00.053462Z","end":"2026-02-13T00:39:00.302705Z","steps":["trace[185561503] 'process raft request' (duration: 248.268291ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:00.302989Z","caller":"traceutil/trace.go:171","msg":"trace[666695365] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"249.485143ms","start":"2026-02-13T00:39:00.053491Z","end":"2026-02-13T00:39:00.302976Z","steps":["trace[666695365] 'process raft request' (duration: 248.280491ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:00.650893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.490098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T00:39:00.65107Z","caller":"traceutil/trace.go:171","msg":"trace[1542485502] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"150.720544ms","start":"2026-02-13T00:39:00.500327Z","end":"2026-02-13T00:39:00.651047Z","steps":["trace[1542485502] 'process raft request' (duration: 150.657704ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:00.651565Z","caller":"traceutil/trace.go:171","msg":"trace[129355612] linearizableReadLoop","detail":"{readStateIndex:360; appliedIndex:359; }","duration":"155.814416ms","start":"2026-02-13T00:39:00.495727Z","end":"2026-02-13T00:39:00.651542Z","steps":["trace[129355612] 'read index received' (duration: 40.587571ms)","trace[129355612] 'applied index is now lower than readState.Index' (duration: 115.225245ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:39:00.651798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.533069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2879"} {"level":"info","ts":"2026-02-13T00:39:00.65189Z","caller":"traceutil/trace.go:171","msg":"trace[446286395] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:350; }","duration":"208.650131ms","start":"2026-02-13T00:39:00.443228Z","end":"2026-02-13T00:39:00.651878Z","steps":["trace[446286395] 'agreement among raft nodes before linearized reading' (duration: 208.496759ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:00.65216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.289657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-02-13T00:39:00.65228Z","caller":"traceutil/trace.go:171","msg":"trace[891775192] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:350; }","duration":"122.426558ms","start":"2026-02-13T00:39:00.529847Z","end":"2026-02-13T00:39:00.652273Z","steps":["trace[891775192] 'agreement among raft nodes before linearized reading' (duration: 122.287266ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:00.653799Z","caller":"traceutil/trace.go:171","msg":"trace[1317813141] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"216.345908ms","start":"2026-02-13T00:39:00.437416Z","end":"2026-02-13T00:39:00.653762Z","steps":["trace[1317813141] 'process raft request' (duration: 98.88818ms)","trace[1317813141] 'compare' (duration: 114.364487ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:39:01.012313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.119192ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T00:39:01.012433Z","caller":"traceutil/trace.go:171","msg":"trace[2063844045] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"272.640137ms","start":"2026-02-13T00:39:00.739775Z","end":"2026-02-13T00:39:01.012415Z","steps":["trace[2063844045] 'process raft request' (duration: 86.246122ms)","trace[2063844045] 'compare' (duration: 185.992501ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:39:09.407096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.110275ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-02-13T00:39:09.407251Z","caller":"traceutil/trace.go:171","msg":"trace[1875043995] transaction","detail":"{read_only:false; number_of_response:1; response_revision:397; }","duration":"882.258373ms","start":"2026-02-13T00:39:08.524981Z","end":"2026-02-13T00:39:09.407239Z","steps":["trace[1875043995] 'process raft request' (duration: 665.895236ms)","trace[1875043995] 'compare' (duration: 215.943043ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:39:09.407294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:08.524963Z","time spent":"882.311493ms","remote":"127.0.0.1:41086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":55,"response count":0,"response size":41,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-02-13T00:39:09.407378Z","caller":"traceutil/trace.go:171","msg":"trace[2023238790] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:410; }","duration":"710.074234ms","start":"2026-02-13T00:39:08.697292Z","end":"2026-02-13T00:39:09.407366Z","steps":["trace[2023238790] 'read index received' (duration: 493.669357ms)","trace[2023238790] 'applied index is now lower than readState.Index' (duration: 216.404207ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:39:09.407445Z","caller":"traceutil/trace.go:171","msg":"trace[1756323937] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"862.998841ms","start":"2026-02-13T00:39:08.544438Z","end":"2026-02-13T00:39:09.407437Z","steps":["trace[1756323937] 'process raft request' (duration: 862.86151ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:09.40748Z","caller":"traceutil/trace.go:171","msg":"trace[1228535597] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"879.967441ms","start":"2026-02-13T00:39:08.527506Z","end":"2026-02-13T00:39:09.407473Z","steps":["trace[1228535597] 'process raft request' (duration: 879.689779ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:09.407505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:08.527499Z","time spent":"879.993112ms","remote":"127.0.0.1:40966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":721,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T00:39:09.407498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:08.544434Z","time spent":"863.031171ms","remote":"127.0.0.1:41344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T00:39:09.407581Z","caller":"traceutil/trace.go:171","msg":"trace[894450367] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"863.215913ms","start":"2026-02-13T00:39:08.544361Z","end":"2026-02-13T00:39:09.407577Z","steps":["trace[894450367] 'process raft request' (duration: 862.90696ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:09.407603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:08.544345Z","time spent":"863.246513ms","remote":"127.0.0.1:41086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3541,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:39:09.407634Z","caller":"traceutil/trace.go:171","msg":"trace[1382242522] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"863.132013ms","start":"2026-02-13T00:39:08.544493Z","end":"2026-02-13T00:39:09.407625Z","steps":["trace[1382242522] 'process raft request' (duration: 862.84221ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:09.407678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:08.544476Z","time spent":"863.180743ms","remote":"127.0.0.1:40966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T00:39:09.407754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.480268ms","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-13T00:39:09.407769Z","caller":"traceutil/trace.go:171","msg":"trace[681239866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:401; }","duration":"643.522268ms","start":"2026-02-13T00:39:08.764242Z","end":"2026-02-13T00:39:09.407765Z","steps":["trace[681239866] 'agreement among raft nodes before linearized reading' (duration: 643.482808ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:09.407782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:08.764224Z","time spent":"643.555268ms","remote":"127.0.0.1:41146","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-13T00:39:09.407849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.564749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-13T00:39:09.40786Z","caller":"traceutil/trace.go:171","msg":"trace[1784237531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:401; }","duration":"710.602519ms","start":"2026-02-13T00:39:08.697254Z","end":"2026-02-13T00:39:09.407857Z","steps":["trace[1784237531] 'agreement among raft nodes before linearized reading' (duration: 710.581649ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:09.407872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:08.697225Z","time spent":"710.643529ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T00:39:09.407927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.952433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-13T00:39:09.40794Z","caller":"traceutil/trace.go:171","msg":"trace[1852335116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:401; }","duration":"364.979683ms","start":"2026-02-13T00:39:09.042957Z","end":"2026-02-13T00:39:09.407936Z","steps":["trace[1852335116] 'agreement among raft nodes before linearized reading' (duration: 364.957492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:09.407951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:09.042949Z","time spent":"365.000203ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-13T00:39:09.408002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.331139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T00:39:09.408033Z","caller":"traceutil/trace.go:171","msg":"trace[1496410675] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:401; }","duration":"406.389199ms","start":"2026-02-13T00:39:09.001634Z","end":"2026-02-13T00:39:09.408024Z","steps":["trace[1496410675] 'agreement among raft nodes before linearized reading' (duration: 406.343919ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:09.408058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:09.001619Z","time spent":"406.43362ms","remote":"127.0.0.1:40914","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-13T00:39:17.602166Z","caller":"traceutil/trace.go:171","msg":"trace[1223493279] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"101.1923ms","start":"2026-02-13T00:39:17.500945Z","end":"2026-02-13T00:39:17.602137Z","steps":["trace[1223493279] 'process raft request' (duration: 26.09467ms)","trace[1223493279] 'compare' (duration: 75.006049ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:39:23.055247Z","caller":"traceutil/trace.go:171","msg":"trace[757609824] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"381.571676ms","start":"2026-02-13T00:39:22.673668Z","end":"2026-02-13T00:39:23.05524Z","steps":["trace[757609824] 'process raft request' (duration: 381.207403ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:23.05539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:22.673642Z","time spent":"381.675367ms","remote":"127.0.0.1:40936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:39:23.055021Z","caller":"traceutil/trace.go:171","msg":"trace[667979661] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:522; }","duration":"182.891024ms","start":"2026-02-13T00:39:22.872116Z","end":"2026-02-13T00:39:23.055007Z","steps":["trace[667979661] 'read index received' (duration: 182.706563ms)","trace[667979661] 'applied index is now lower than readState.Index' (duration: 183.931µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:39:23.056077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.955293ms","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-13T00:39:23.056149Z","caller":"traceutil/trace.go:171","msg":"trace[630211159] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:506; }","duration":"184.021825ms","start":"2026-02-13T00:39:22.872072Z","end":"2026-02-13T00:39:23.056094Z","steps":["trace[630211159] 'agreement among raft nodes before linearized reading' (duration: 183.910194ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:23.711151Z","caller":"traceutil/trace.go:171","msg":"trace[333369149] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"435.461416ms","start":"2026-02-13T00:39:23.27568Z","end":"2026-02-13T00:39:23.711141Z","steps":["trace[333369149] 'process raft request' (duration: 435.390166ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:23.711227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:23.275665Z","time spent":"435.527277ms","remote":"127.0.0.1:40936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T00:39:23.71581Z","caller":"traceutil/trace.go:171","msg":"trace[1982955327] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"198.661722ms","start":"2026-02-13T00:39:23.517139Z","end":"2026-02-13T00:39:23.7158Z","steps":["trace[1982955327] 'read index received' (duration: 194.319725ms)","trace[1982955327] 'applied index is now lower than readState.Index' (duration: 4.341567ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:39:23.715904Z","caller":"traceutil/trace.go:171","msg":"trace[664877139] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"243.216669ms","start":"2026-02-13T00:39:23.472681Z","end":"2026-02-13T00:39:23.715898Z","steps":["trace[664877139] 'process raft request' (duration: 243.077827ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:23.716044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.896694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-13T00:39:23.716073Z","caller":"traceutil/trace.go:171","msg":"trace[1663912985] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"198.948484ms","start":"2026-02-13T00:39:23.517116Z","end":"2026-02-13T00:39:23.716064Z","steps":["trace[1663912985] 'agreement among raft nodes before linearized reading' (duration: 198.878273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:23.716179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.236518ms","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-13T00:39:23.716202Z","caller":"traceutil/trace.go:171","msg":"trace[1965629237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"159.278028ms","start":"2026-02-13T00:39:23.556919Z","end":"2026-02-13T00:39:23.716197Z","steps":["trace[1965629237] 'agreement among raft nodes before linearized reading' (duration: 159.241458ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:28.344985Z","caller":"traceutil/trace.go:171","msg":"trace[87808215] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:578; }","duration":"255.055092ms","start":"2026-02-13T00:39:28.089909Z","end":"2026-02-13T00:39:28.344964Z","steps":["trace[87808215] 'read index received' (duration: 254.8185ms)","trace[87808215] 'applied index is now lower than readState.Index' (duration: 235.612µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:39:28.346242Z","caller":"traceutil/trace.go:171","msg":"trace[999106287] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"342.24529ms","start":"2026-02-13T00:39:28.003978Z","end":"2026-02-13T00:39:28.346223Z","steps":["trace[999106287] 'process raft request' (duration: 340.842018ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:28.346382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:28.003971Z","time spent":"342.332501ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T00:39:28.346761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.826376ms","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-13T00:39:28.346803Z","caller":"traceutil/trace.go:171","msg":"trace[1668329304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:561; }","duration":"256.916577ms","start":"2026-02-13T00:39:28.089876Z","end":"2026-02-13T00:39:28.346792Z","steps":["trace[1668329304] 'agreement among raft nodes before linearized reading' (duration: 256.778385ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:28.34706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.259352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T00:39:28.347121Z","caller":"traceutil/trace.go:171","msg":"trace[818393050] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:561; }","duration":"222.339122ms","start":"2026-02-13T00:39:28.124771Z","end":"2026-02-13T00:39:28.34711Z","steps":["trace[818393050] 'agreement among raft nodes before linearized reading' (duration: 222.205041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:28.347718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.885467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T00:39:28.347747Z","caller":"traceutil/trace.go:171","msg":"trace[2072477548] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:561; }","duration":"222.919717ms","start":"2026-02-13T00:39:28.12482Z","end":"2026-02-13T00:39:28.34774Z","steps":["trace[2072477548] 'agreement among raft nodes before linearized reading' (duration: 222.844427ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:28.347951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.134399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T00:39:28.347979Z","caller":"traceutil/trace.go:171","msg":"trace[398058193] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:561; }","duration":"223.169139ms","start":"2026-02-13T00:39:28.124802Z","end":"2026-02-13T00:39:28.347971Z","steps":["trace[398058193] 'agreement among raft nodes before linearized reading' (duration: 223.126699ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:30.043334Z","caller":"traceutil/trace.go:171","msg":"trace[1588865755] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"177.569964ms","start":"2026-02-13T00:39:29.865748Z","end":"2026-02-13T00:39:30.043318Z","steps":["trace[1588865755] 'process raft request' (duration: 177.280832ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:30.872579Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870728847731420,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-13T00:39:31.060043Z","caller":"traceutil/trace.go:171","msg":"trace[54953759] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:586; }","duration":"693.212504ms","start":"2026-02-13T00:39:30.366811Z","end":"2026-02-13T00:39:31.060023Z","steps":["trace[54953759] 'read index received' (duration: 693.029023ms)","trace[54953759] 'applied index is now lower than readState.Index' (duration: 182.421µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T00:39:31.060133Z","caller":"traceutil/trace.go:171","msg":"trace[1675981431] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"707.011896ms","start":"2026-02-13T00:39:30.353113Z","end":"2026-02-13T00:39:31.060125Z","steps":["trace[1675981431] 'process raft request' (duration: 706.743764ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:31.060221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:30.353102Z","time spent":"707.048556ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T00:39:31.060404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.890742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-v8fkf\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-13T00:39:31.060459Z","caller":"traceutil/trace.go:171","msg":"trace[298460701] range","detail":"{range_begin:/registry/pods/kube-system/cilium-v8fkf; range_end:; response_count:1; response_revision:569; }","duration":"507.970903ms","start":"2026-02-13T00:39:30.552466Z","end":"2026-02-13T00:39:31.060437Z","steps":["trace[298460701] 'agreement among raft nodes before linearized reading' (duration: 507.811401ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:31.060483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:30.552452Z","time spent":"508.026673ms","remote":"127.0.0.1:41086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-v8fkf\" "} {"level":"warn","ts":"2026-02-13T00:39:31.060625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.809299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-02-13T00:39:31.060652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.4179ms","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-13T00:39:31.060685Z","caller":"traceutil/trace.go:171","msg":"trace[104778705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:569; }","duration":"386.469791ms","start":"2026-02-13T00:39:30.674206Z","end":"2026-02-13T00:39:31.060675Z","steps":["trace[104778705] 'agreement among raft nodes before linearized reading' (duration: 386.40713ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:31.0607Z","caller":"traceutil/trace.go:171","msg":"trace[1026420720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:569; }","duration":"693.852179ms","start":"2026-02-13T00:39:30.366808Z","end":"2026-02-13T00:39:31.06066Z","steps":["trace[1026420720] 'agreement among raft nodes before linearized reading' (duration: 693.759599ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:31.060724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:30.366775Z","time spent":"693.94401ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-13T00:39:31.060706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:30.674191Z","time spent":"386.511701ms","remote":"127.0.0.1:41146","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-13T00:39:31.743988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.668188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T00:39:31.744278Z","caller":"traceutil/trace.go:171","msg":"trace[1129118187] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"672.347609ms","start":"2026-02-13T00:39:31.0719Z","end":"2026-02-13T00:39:31.744247Z","steps":["trace[1129118187] 'process raft request' (duration: 87.337249ms)","trace[1129118187] 'compare' (duration: 584.498776ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:39:31.744489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:31.071884Z","time spent":"672.48474ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T00:39:31.744691Z","caller":"traceutil/trace.go:171","msg":"trace[747968100] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"672.716433ms","start":"2026-02-13T00:39:31.071956Z","end":"2026-02-13T00:39:31.744672Z","steps":["trace[747968100] 'process raft request' (duration: 672.157158ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:31.744764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:31.071946Z","time spent":"672.781583ms","remote":"127.0.0.1:41086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T00:39:31.744878Z","caller":"traceutil/trace.go:171","msg":"trace[422755678] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"664.938289ms","start":"2026-02-13T00:39:31.07988Z","end":"2026-02-13T00:39:31.744819Z","steps":["trace[422755678] 'process raft request' (duration: 664.355754ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:31.74493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:31.079873Z","time spent":"665.02135ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T00:39:32.500718Z","caller":"traceutil/trace.go:171","msg":"trace[2137781911] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"498.060216ms","start":"2026-02-13T00:39:32.002638Z","end":"2026-02-13T00:39:32.500698Z","steps":["trace[2137781911] 'read index received' (duration: 413.007229ms)","trace[2137781911] 'applied index is now lower than readState.Index' (duration: 85.051987ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:39:32.500804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:31.751142Z","time spent":"749.659429ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-13T00:39:32.50154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.789126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-13T00:39:32.501569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.919003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T00:39:32.501594Z","caller":"traceutil/trace.go:171","msg":"trace[204764035] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"498.987643ms","start":"2026-02-13T00:39:32.0026Z","end":"2026-02-13T00:39:32.501588Z","steps":["trace[204764035] 'agreement among raft nodes before linearized reading' (duration: 498.933283ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:32.501602Z","caller":"traceutil/trace.go:171","msg":"trace[1719921857] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:573; }","duration":"454.904777ms","start":"2026-02-13T00:39:32.04668Z","end":"2026-02-13T00:39:32.501585Z","steps":["trace[1719921857] 'agreement among raft nodes before linearized reading' (duration: 454.710906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:32.501628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:32.002583Z","time spent":"499.041354ms","remote":"127.0.0.1:40914","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-13T00:39:32.501647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:32.046666Z","time spent":"454.972548ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T00:39:32.501836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.801251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T00:39:32.501853Z","caller":"traceutil/trace.go:171","msg":"trace[1815469836] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:573; }","duration":"446.829961ms","start":"2026-02-13T00:39:32.055017Z","end":"2026-02-13T00:39:32.501847Z","steps":["trace[1815469836] 'agreement among raft nodes before linearized reading' (duration: 446.730111ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:32.501868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T00:39:32.05498Z","time spent":"446.883502ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-13T00:39:52.060048Z","caller":"traceutil/trace.go:171","msg":"trace[499944768] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"241.19647ms","start":"2026-02-13T00:39:51.818843Z","end":"2026-02-13T00:39:52.06004Z","steps":["trace[499944768] 'process raft request' (duration: 236.925897ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:39:52.059995Z","caller":"traceutil/trace.go:171","msg":"trace[2042207724] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:752; }","duration":"230.045635ms","start":"2026-02-13T00:39:51.82993Z","end":"2026-02-13T00:39:52.059976Z","steps":["trace[2042207724] 'read index received' (duration: 225.824163ms)","trace[2042207724] 'applied index is now lower than readState.Index' (duration: 4.220832ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T00:39:52.060488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.388383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T00:39:52.060532Z","caller":"traceutil/trace.go:171","msg":"trace[567798612] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:729; }","duration":"125.445835ms","start":"2026-02-13T00:39:51.935077Z","end":"2026-02-13T00:39:52.060523Z","steps":["trace[567798612] 'agreement among raft nodes before linearized reading' (duration: 125.346181ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T00:39:52.060857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.922226ms","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-13T00:39:52.060881Z","caller":"traceutil/trace.go:171","msg":"trace[353677467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:729; }","duration":"230.947367ms","start":"2026-02-13T00:39:51.829927Z","end":"2026-02-13T00:39:52.060874Z","steps":["trace[353677467] 'agreement among raft nodes before linearized reading' (duration: 230.47333ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T00:40:58.685647Z","caller":"traceutil/trace.go:171","msg":"trace[471189596] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"214.852277ms","start":"2026-02-13T00:40:58.470777Z","end":"2026-02-13T00:40:58.685629Z","steps":["trace[471189596] 'process raft request' (duration: 214.721504ms)"],"step_count":1}