{"level":"warn","ts":"2026-01-19T16:06:59.114899Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-01-19T16:06:59.115329Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.136:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.136:2380","--initial-cluster=instance=https://199.19.213.136:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.136:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.136: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-01-19T16:06:59.115529Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-01-19T16:06:59.115619Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.136:2380"]} {"level":"info","ts":"2026-01-19T16:06:59.115699Z","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-01-19T16:06:59.116734Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"]} {"level":"info","ts":"2026-01-19T16:06:59.116932Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.136:2380"],"listen-peer-urls":["https://199.19.213.136:2380"],"advertise-client-urls":["https://199.19.213.136:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.136: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-01-19T16:06:59.126062Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.687161ms"} {"level":"info","ts":"2026-01-19T16:06:59.140674Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bcbe0b88c51dc5e5","cluster-id":"e591ddd6f6a32da9"} {"level":"info","ts":"2026-01-19T16:06:59.140793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=()"} {"level":"info","ts":"2026-01-19T16:06:59.140889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became follower at term 0"} {"level":"info","ts":"2026-01-19T16:06:59.140987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bcbe0b88c51dc5e5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-01-19T16:06:59.141021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became follower at term 1"} {"level":"info","ts":"2026-01-19T16:06:59.141086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=(13600320606755997157)"} {"level":"warn","ts":"2026-01-19T16:06:59.150784Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-01-19T16:06:59.16003Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-01-19T16:06:59.165278Z","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-01-19T16:06:59.172451Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bcbe0b88c51dc5e5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-01-19T16:06:59.172996Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bcbe0b88c51dc5e5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-01-19T16:06:59.17325Z","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-01-19T16:06:59.173298Z","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-01-19T16:06:59.173317Z","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-01-19T16:06:59.174071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=(13600320606755997157)"} {"level":"info","ts":"2026-01-19T16:06:59.174971Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e591ddd6f6a32da9","local-member-id":"bcbe0b88c51dc5e5","added-peer-id":"bcbe0b88c51dc5e5","added-peer-peer-urls":["https://199.19.213.136:2380"]} {"level":"info","ts":"2026-01-19T16:06:59.180384Z","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-01-19T16:06:59.186004Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.136:2380"} {"level":"info","ts":"2026-01-19T16:06:59.186024Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.136:2380"} {"level":"info","ts":"2026-01-19T16:06:59.186326Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bcbe0b88c51dc5e5","initial-advertise-peer-urls":["https://199.19.213.136:2380"],"listen-peer-urls":["https://199.19.213.136:2380"],"advertise-client-urls":["https://199.19.213.136:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-01-19T16:06:59.186352Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-01-19T16:07:00.142344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 is starting a new election at term 1"} {"level":"info","ts":"2026-01-19T16:07:00.142419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became pre-candidate at term 1"} {"level":"info","ts":"2026-01-19T16:07:00.142451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 received MsgPreVoteResp from bcbe0b88c51dc5e5 at term 1"} {"level":"info","ts":"2026-01-19T16:07:00.14247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became candidate at term 2"} {"level":"info","ts":"2026-01-19T16:07:00.142478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 received MsgVoteResp from bcbe0b88c51dc5e5 at term 2"} {"level":"info","ts":"2026-01-19T16:07:00.14249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became leader at term 2"} {"level":"info","ts":"2026-01-19T16:07:00.142506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bcbe0b88c51dc5e5 elected leader bcbe0b88c51dc5e5 at term 2"} {"level":"info","ts":"2026-01-19T16:07:00.143623Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bcbe0b88c51dc5e5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.136:2379]}","request-path":"/0/members/bcbe0b88c51dc5e5/attributes","cluster-id":"e591ddd6f6a32da9","publish-timeout":"7s"} {"level":"info","ts":"2026-01-19T16:07:00.14378Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-01-19T16:07:00.144152Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-01-19T16:07:00.144248Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-01-19T16:07:00.144404Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-01-19T16:07:00.14443Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-01-19T16:07:00.146941Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.136:2379"} {"level":"info","ts":"2026-01-19T16:07:00.147123Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e591ddd6f6a32da9","local-member-id":"bcbe0b88c51dc5e5","cluster-version":"3.5"} {"level":"info","ts":"2026-01-19T16:07:00.147223Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-01-19T16:07:00.147249Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-01-19T16:07:00.150072Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-01-19T16:07:10.544169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.805471ms","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-01-19T16:07:10.544323Z","caller":"traceutil/trace.go:171","msg":"trace[414759155] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:353; }","duration":"489.596737ms","start":"2026-01-19T16:07:10.054701Z","end":"2026-01-19T16:07:10.544298Z","steps":["trace[414759155] 'range keys from in-memory index tree' (duration: 487.724239ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:10.544391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:10.054684Z","time spent":"489.692771ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-01-19T16:07:10.54491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.801526ms","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-01-19T16:07:10.544933Z","caller":"traceutil/trace.go:171","msg":"trace[1195142582] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:353; }","duration":"431.856958ms","start":"2026-01-19T16:07:10.113068Z","end":"2026-01-19T16:07:10.544925Z","steps":["trace[1195142582] 'range keys from in-memory index tree' (duration: 431.749443ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:10.54495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:10.11306Z","time spent":"431.886239ms","remote":"127.0.0.1:46902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7261,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-01-19T16:07:10.545064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.114087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-01-19T16:07:10.545082Z","caller":"traceutil/trace.go:171","msg":"trace[780806339] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:353; }","duration":"454.153349ms","start":"2026-01-19T16:07:10.090922Z","end":"2026-01-19T16:07:10.545075Z","steps":["trace[780806339] 'range keys from in-memory index tree' (duration: 454.035905ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:10.545098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:10.090909Z","time spent":"454.184311ms","remote":"127.0.0.1:46898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4037,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-01-19T16:07:10.545402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.569532ms","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-01-19T16:07:10.545433Z","caller":"traceutil/trace.go:171","msg":"trace[1800955332] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:353; }","duration":"227.046575ms","start":"2026-01-19T16:07:10.318377Z","end":"2026-01-19T16:07:10.545423Z","steps":["trace[1800955332] 'range keys from in-memory index tree' (duration: 224.461457ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:16.306426Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14259975142899533907,"retry-timeout":"500ms"} {"level":"info","ts":"2026-01-19T16:07:16.38533Z","caller":"traceutil/trace.go:171","msg":"trace[1285429205] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:380; }","duration":"579.645337ms","start":"2026-01-19T16:07:15.805657Z","end":"2026-01-19T16:07:16.385303Z","steps":["trace[1285429205] 'read index received' (duration: 578.869988ms)","trace[1285429205] 'applied index is now lower than readState.Index' (duration: 774.029µs)"],"step_count":2} {"level":"info","ts":"2026-01-19T16:07:16.386024Z","caller":"traceutil/trace.go:171","msg":"trace[552993340] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"651.821991ms","start":"2026-01-19T16:07:15.734193Z","end":"2026-01-19T16:07:16.386015Z","steps":["trace[552993340] 'process raft request' (duration: 650.413667ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:16.386389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.390021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-01-19T16:07:16.386531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:15.734162Z","time spent":"651.890103ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-19T16:07:16.386717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.057742ms","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-01-19T16:07:16.3868Z","caller":"traceutil/trace.go:171","msg":"trace[1456781552] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:372; }","duration":"581.178296ms","start":"2026-01-19T16:07:15.805616Z","end":"2026-01-19T16:07:16.386794Z","steps":["trace[1456781552] 'agreement among raft nodes before linearized reading' (duration: 581.056261ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:16.386893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:15.805585Z","time spent":"581.299992ms","remote":"127.0.0.1:46902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6922,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-01-19T16:07:16.386547Z","caller":"traceutil/trace.go:171","msg":"trace[294952059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:372; }","duration":"555.600169ms","start":"2026-01-19T16:07:15.83093Z","end":"2026-01-19T16:07:16.386531Z","steps":["trace[294952059] 'agreement among raft nodes before linearized reading' (duration: 555.400251ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:16.387325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:15.830911Z","time spent":"556.40456ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-01-19T16:07:16.38743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.748686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-19T16:07:16.387575Z","caller":"traceutil/trace.go:171","msg":"trace[730101447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:372; }","duration":"395.937123ms","start":"2026-01-19T16:07:15.991631Z","end":"2026-01-19T16:07:16.387568Z","steps":["trace[730101447] 'agreement among raft nodes before linearized reading' (duration: 395.779037ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:16.387662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:15.991609Z","time spent":"396.046768ms","remote":"127.0.0.1:46702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-01-19T16:07:32.461073Z","caller":"traceutil/trace.go:171","msg":"trace[375857546] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:489; }","duration":"469.597105ms","start":"2026-01-19T16:07:31.991451Z","end":"2026-01-19T16:07:32.461048Z","steps":["trace[375857546] 'read index received' (duration: 469.405299ms)","trace[375857546] 'applied index is now lower than readState.Index' (duration: 189.706µs)"],"step_count":2} {"level":"warn","ts":"2026-01-19T16:07:32.461243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.759831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-19T16:07:32.461271Z","caller":"traceutil/trace.go:171","msg":"trace[1797424762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:477; }","duration":"469.837623ms","start":"2026-01-19T16:07:31.991425Z","end":"2026-01-19T16:07:32.461262Z","steps":["trace[1797424762] 'agreement among raft nodes before linearized reading' (duration: 469.74276ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:32.461308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:31.991413Z","time spent":"469.888005ms","remote":"127.0.0.1:46706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-01-19T16:07:32.461511Z","caller":"traceutil/trace.go:171","msg":"trace[305597548] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"522.480414ms","start":"2026-01-19T16:07:31.939023Z","end":"2026-01-19T16:07:32.461503Z","steps":["trace[305597548] 'process raft request' (duration: 521.896205ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:32.461577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:31.939009Z","time spent":"522.519026ms","remote":"127.0.0.1:46898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4211,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-19T16:07:39.378485Z","caller":"traceutil/trace.go:171","msg":"trace[166173911] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"168.878788ms","start":"2026-01-19T16:07:39.209269Z","end":"2026-01-19T16:07:39.378148Z","steps":["trace[166173911] 'process raft request' (duration: 168.726233ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:41.023826Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14259975142899534215,"retry-timeout":"500ms"} {"level":"info","ts":"2026-01-19T16:07:41.076315Z","caller":"traceutil/trace.go:171","msg":"trace[30682433] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"553.221292ms","start":"2026-01-19T16:07:40.523072Z","end":"2026-01-19T16:07:41.076293Z","steps":["trace[30682433] 'read index received' (duration: 553.051477ms)","trace[30682433] 'applied index is now lower than readState.Index' (duration: 169.145µs)"],"step_count":2} {"level":"info","ts":"2026-01-19T16:07:41.07643Z","caller":"traceutil/trace.go:171","msg":"trace[1311851382] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"562.306309ms","start":"2026-01-19T16:07:40.514115Z","end":"2026-01-19T16:07:41.076422Z","steps":["trace[1311851382] 'process raft request' (duration: 562.062052ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:41.076526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:40.514103Z","time spent":"562.34595ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-19T16:07:41.076764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.121311ms","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-01-19T16:07:41.076828Z","caller":"traceutil/trace.go:171","msg":"trace[976369944] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"316.243125ms","start":"2026-01-19T16:07:40.760567Z","end":"2026-01-19T16:07:41.076811Z","steps":["trace[976369944] 'agreement among raft nodes before linearized reading' (duration: 316.07501ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:41.07686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:40.760543Z","time spent":"316.309036ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-01-19T16:07:41.077015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.943624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-01-19T16:07:41.07703Z","caller":"traceutil/trace.go:171","msg":"trace[1645476891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:523; }","duration":"553.975004ms","start":"2026-01-19T16:07:40.523048Z","end":"2026-01-19T16:07:41.077023Z","steps":["trace[1645476891] 'agreement among raft nodes before linearized reading' (duration: 553.919503ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:41.077042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:40.523037Z","time spent":"554.001805ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-01-19T16:07:41.07753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.443042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-01-19T16:07:41.077547Z","caller":"traceutil/trace.go:171","msg":"trace[1323787305] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:523; }","duration":"311.477913ms","start":"2026-01-19T16:07:40.766064Z","end":"2026-01-19T16:07:41.077542Z","steps":["trace[1323787305] 'agreement among raft nodes before linearized reading' (duration: 311.430261ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:07:41.077569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:07:40.766056Z","time spent":"311.509463ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-01-19T16:07:42.670364Z","caller":"traceutil/trace.go:171","msg":"trace[1485210866] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"101.894777ms","start":"2026-01-19T16:07:42.56797Z","end":"2026-01-19T16:07:42.669865Z","steps":["trace[1485210866] 'process raft request' (duration: 98.876989ms)"],"step_count":1} {"level":"info","ts":"2026-01-19T16:07:52.588394Z","caller":"traceutil/trace.go:171","msg":"trace[704637786] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"149.553191ms","start":"2026-01-19T16:07:52.438821Z","end":"2026-01-19T16:07:52.588375Z","steps":["trace[704637786] 'process raft request' (duration: 149.51001ms)"],"step_count":1} {"level":"info","ts":"2026-01-19T16:07:52.588737Z","caller":"traceutil/trace.go:171","msg":"trace[484590827] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"150.119156ms","start":"2026-01-19T16:07:52.438612Z","end":"2026-01-19T16:07:52.588731Z","steps":["trace[484590827] 'process raft request' (duration: 149.263293ms)"],"step_count":1} {"level":"info","ts":"2026-01-19T16:07:53.394883Z","caller":"traceutil/trace.go:171","msg":"trace[678927622] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"115.030058ms","start":"2026-01-19T16:07:53.279832Z","end":"2026-01-19T16:07:53.394862Z","steps":["trace[678927622] 'process raft request' (duration: 94.939018ms)","trace[678927622] 'compare' (duration: 19.892505ms)"],"step_count":2} {"level":"info","ts":"2026-01-19T16:08:03.729781Z","caller":"traceutil/trace.go:171","msg":"trace[1376708935] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"120.210632ms","start":"2026-01-19T16:08:03.609543Z","end":"2026-01-19T16:08:03.729753Z","steps":["trace[1376708935] 'process raft request' (duration: 110.161496ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:29.148066Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.26261915s","expected-duration":"1s"} {"level":"info","ts":"2026-01-19T16:08:29.148347Z","caller":"traceutil/trace.go:171","msg":"trace[2139735310] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"1.262961477s","start":"2026-01-19T16:08:27.885366Z","end":"2026-01-19T16:08:29.148328Z","steps":["trace[2139735310] 'process raft request' (duration: 1.262872976s)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:29.14846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:27.885357Z","time spent":"1.263047878s","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-19T16:08:29.169019Z","caller":"traceutil/trace.go:171","msg":"trace[1214620656] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"1.283446394s","start":"2026-01-19T16:08:27.885543Z","end":"2026-01-19T16:08:29.168989Z","steps":["trace[1214620656] 'process raft request' (duration: 1.282915334s)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:29.169182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:27.885501Z","time spent":"1.283576837s","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-19T16:08:29.169353Z","caller":"traceutil/trace.go:171","msg":"trace[1043494224] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"1.280110501s","start":"2026-01-19T16:08:27.889235Z","end":"2026-01-19T16:08:29.169346Z","steps":["trace[1043494224] 'process raft request' (duration: 1.279362287s)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:29.169385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:27.889228Z","time spent":"1.280138862s","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-19T16:08:29.169456Z","caller":"traceutil/trace.go:171","msg":"trace[1540192724] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"1.280097861s","start":"2026-01-19T16:08:27.889339Z","end":"2026-01-19T16:08:29.169437Z","steps":["trace[1540192724] 'process raft request' (duration: 1.279316206s)"],"step_count":1} {"level":"info","ts":"2026-01-19T16:08:29.169554Z","caller":"traceutil/trace.go:171","msg":"trace[810566391] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"1.280240554s","start":"2026-01-19T16:08:27.889306Z","end":"2026-01-19T16:08:29.169546Z","steps":["trace[810566391] 'process raft request' (duration: 1.279318836s)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:29.169553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:27.889335Z","time spent":"1.280162272s","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-19T16:08:29.169586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:27.889302Z","time spent":"1.280269325s","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-19T16:08:33.854238Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14259975142899534853,"retry-timeout":"500ms"} {"level":"info","ts":"2026-01-19T16:08:34.052632Z","caller":"traceutil/trace.go:171","msg":"trace[2120864129] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"699.846015ms","start":"2026-01-19T16:08:33.35276Z","end":"2026-01-19T16:08:34.052606Z","steps":["trace[2120864129] 'process raft request' (duration: 699.736623ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:34.052875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:33.351736Z","time spent":"701.022018ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-19T16:08:34.125884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:33.354125Z","time spent":"771.753011ms","remote":"127.0.0.1:46738","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-01-19T16:08:34.126079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.946764ms","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-01-19T16:08:34.126139Z","caller":"traceutil/trace.go:171","msg":"trace[2016664108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:813; }","duration":"772.034685ms","start":"2026-01-19T16:08:33.354096Z","end":"2026-01-19T16:08:34.126131Z","steps":["trace[2016664108] 'agreement among raft nodes before linearized reading' (duration: 771.853082ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:34.126173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:33.354089Z","time spent":"772.077266ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-01-19T16:08:34.125913Z","caller":"traceutil/trace.go:171","msg":"trace[1092180919] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:835; }","duration":"771.783942ms","start":"2026-01-19T16:08:33.35411Z","end":"2026-01-19T16:08:34.125894Z","steps":["trace[1092180919] 'read index received' (duration: 698.743786ms)","trace[1092180919] 'applied index is now lower than readState.Index' (duration: 73.039636ms)"],"step_count":2} {"level":"info","ts":"2026-01-19T16:08:34.126489Z","caller":"traceutil/trace.go:171","msg":"trace[1504466286] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"771.26249ms","start":"2026-01-19T16:08:33.355219Z","end":"2026-01-19T16:08:34.126481Z","steps":["trace[1504466286] 'process raft request' (duration: 770.564058ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:34.126547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:33.35521Z","time spent":"771.298471ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-19T16:08:34.126654Z","caller":"traceutil/trace.go:171","msg":"trace[719457070] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"770.679389ms","start":"2026-01-19T16:08:33.355934Z","end":"2026-01-19T16:08:34.126613Z","steps":["trace[719457070] 'process raft request' (duration: 769.909886ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:34.126685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:33.35592Z","time spent":"770.750051ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-19T16:08:34.126747Z","caller":"traceutil/trace.go:171","msg":"trace[1346870540] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"769.911946ms","start":"2026-01-19T16:08:33.356831Z","end":"2026-01-19T16:08:34.126743Z","steps":["trace[1346870540] 'process raft request' (duration: 769.028991ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:34.126777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-19T16:08:33.356824Z","time spent":"769.939277ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-19T16:08:34.126842Z","caller":"traceutil/trace.go:171","msg":"trace[951416632] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"131.481995ms","start":"2026-01-19T16:08:33.995355Z","end":"2026-01-19T16:08:34.126837Z","steps":["trace[951416632] 'process raft request' (duration: 130.519958ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:08:34.126942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.441165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-19T16:08:34.127032Z","caller":"traceutil/trace.go:171","msg":"trace[1073888733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:813; }","duration":"131.555646ms","start":"2026-01-19T16:08:33.995461Z","end":"2026-01-19T16:08:34.127017Z","steps":["trace[1073888733] 'agreement among raft nodes before linearized reading' (duration: 131.377483ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:09:17.867569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.377718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-19T16:09:17.867641Z","caller":"traceutil/trace.go:171","msg":"trace[1439643831] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:970; }","duration":"123.489409ms","start":"2026-01-19T16:09:17.744137Z","end":"2026-01-19T16:09:17.867626Z","steps":["trace[1439643831] 'count revisions from in-memory index tree' (duration: 123.330286ms)"],"step_count":1} {"level":"info","ts":"2026-01-19T16:09:18.514158Z","caller":"traceutil/trace.go:171","msg":"trace[1707765770] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"213.310458ms","start":"2026-01-19T16:09:18.30083Z","end":"2026-01-19T16:09:18.51414Z","steps":["trace[1707765770] 'process raft request' (duration: 213.214267ms)"],"step_count":1} {"level":"info","ts":"2026-01-19T16:09:18.526313Z","caller":"traceutil/trace.go:171","msg":"trace[112179438] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"169.048455ms","start":"2026-01-19T16:09:18.357252Z","end":"2026-01-19T16:09:18.526301Z","steps":["trace[112179438] 'process raft request' (duration: 168.844172ms)"],"step_count":1} {"level":"info","ts":"2026-01-19T16:09:18.537619Z","caller":"traceutil/trace.go:171","msg":"trace[488659077] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1008; }","duration":"162.182699ms","start":"2026-01-19T16:09:18.375419Z","end":"2026-01-19T16:09:18.537602Z","steps":["trace[488659077] 'read index received' (duration: 138.88616ms)","trace[488659077] 'applied index is now lower than readState.Index' (duration: 23.295269ms)"],"step_count":2} {"level":"warn","ts":"2026-01-19T16:09:18.538044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.607274ms","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-01-19T16:09:18.539488Z","caller":"traceutil/trace.go:171","msg":"trace[2065068762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:972; }","duration":"164.079645ms","start":"2026-01-19T16:09:18.375394Z","end":"2026-01-19T16:09:18.539473Z","steps":["trace[2065068762] 'agreement among raft nodes before linearized reading' (duration: 162.436131ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:09:18.542216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.155874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-01-19T16:09:18.54226Z","caller":"traceutil/trace.go:171","msg":"trace[207644884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:972; }","duration":"120.223786ms","start":"2026-01-19T16:09:18.422023Z","end":"2026-01-19T16:09:18.542247Z","steps":["trace[207644884] 'agreement among raft nodes before linearized reading' (duration: 120.097254ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:09:18.542796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.772342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-01-19T16:09:18.542834Z","caller":"traceutil/trace.go:171","msg":"trace[1564086854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:972; }","duration":"110.826403ms","start":"2026-01-19T16:09:18.431997Z","end":"2026-01-19T16:09:18.542824Z","steps":["trace[1564086854] 'agreement among raft nodes before linearized reading' (duration: 110.714111ms)"],"step_count":1} {"level":"warn","ts":"2026-01-19T16:09:18.543008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.563103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-01-19T16:09:18.543035Z","caller":"traceutil/trace.go:171","msg":"trace[1402999237] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:972; }","duration":"106.621744ms","start":"2026-01-19T16:09:18.436405Z","end":"2026-01-19T16:09:18.543027Z","steps":["trace[1402999237] 'agreement among raft nodes before linearized reading' (duration: 106.549973ms)"],"step_count":1}