{"level":"warn","ts":"2026-02-11T02:26:45.489865Z","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-11T02:26:45.489994Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.220: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.220:2380","--initial-cluster=instance=https://199.19.213.220:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.220:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.220: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-11T02:26:45.490106Z","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-11T02:26:45.490147Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.220:2380"]} {"level":"info","ts":"2026-02-11T02:26:45.490184Z","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-11T02:26:45.490822Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.220:2379"]} {"level":"info","ts":"2026-02-11T02:26:45.490919Z","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.220:2380"],"listen-peer-urls":["https://199.19.213.220:2380"],"advertise-client-urls":["https://199.19.213.220:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.220:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.220: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-11T02:26:45.541241Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"49.978272ms"} {"level":"info","ts":"2026-02-11T02:26:45.578839Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab3c4fae41c4ba3","cluster-id":"574139c3944fcfd2"} {"level":"info","ts":"2026-02-11T02:26:45.578963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 switched to configuration voters=()"} {"level":"info","ts":"2026-02-11T02:26:45.579009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 became follower at term 0"} {"level":"info","ts":"2026-02-11T02:26:45.579055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab3c4fae41c4ba3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-11T02:26:45.579075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 became follower at term 1"} {"level":"info","ts":"2026-02-11T02:26:45.579138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 switched to configuration voters=(771176543058414499)"} {"level":"warn","ts":"2026-02-11T02:26:45.597949Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-11T02:26:45.609711Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-11T02:26:45.611304Z","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-11T02:26:45.613226Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab3c4fae41c4ba3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-11T02:26:45.61388Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab3c4fae41c4ba3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-11T02:26:45.613999Z","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-11T02:26:45.614024Z","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-11T02:26:45.614038Z","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-11T02:26:45.614312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 switched to configuration voters=(771176543058414499)"} {"level":"info","ts":"2026-02-11T02:26:45.614398Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"574139c3944fcfd2","local-member-id":"ab3c4fae41c4ba3","added-peer-id":"ab3c4fae41c4ba3","added-peer-peer-urls":["https://199.19.213.220:2380"]} {"level":"info","ts":"2026-02-11T02:26:45.61747Z","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-11T02:26:45.617646Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.220:2380"} {"level":"info","ts":"2026-02-11T02:26:45.61766Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.220:2380"} {"level":"info","ts":"2026-02-11T02:26:45.618914Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab3c4fae41c4ba3","initial-advertise-peer-urls":["https://199.19.213.220:2380"],"listen-peer-urls":["https://199.19.213.220:2380"],"advertise-client-urls":["https://199.19.213.220:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.220:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-11T02:26:45.618997Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-11T02:26:45.98116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 is starting a new election at term 1"} {"level":"info","ts":"2026-02-11T02:26:45.981218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-11T02:26:45.981243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 received MsgPreVoteResp from ab3c4fae41c4ba3 at term 1"} {"level":"info","ts":"2026-02-11T02:26:45.981343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 became candidate at term 2"} {"level":"info","ts":"2026-02-11T02:26:45.981356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 received MsgVoteResp from ab3c4fae41c4ba3 at term 2"} {"level":"info","ts":"2026-02-11T02:26:45.981367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 became leader at term 2"} {"level":"info","ts":"2026-02-11T02:26:45.981376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab3c4fae41c4ba3 elected leader ab3c4fae41c4ba3 at term 2"} {"level":"info","ts":"2026-02-11T02:26:45.98726Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:26:45.990964Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab3c4fae41c4ba3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.220:2379]}","request-path":"/0/members/ab3c4fae41c4ba3/attributes","cluster-id":"574139c3944fcfd2","publish-timeout":"7s"} {"level":"info","ts":"2026-02-11T02:26:45.99099Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T02:26:45.991835Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T02:26:45.992008Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"574139c3944fcfd2","local-member-id":"ab3c4fae41c4ba3","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:26:45.992192Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:26:45.992221Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:26:45.992892Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-11T02:26:45.992958Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-11T02:26:45.994917Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-11T02:26:45.99784Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.220:2379"} {"level":"info","ts":"2026-02-11T02:27:08.888246Z","caller":"traceutil/trace.go:171","msg":"trace[930304631] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"195.459551ms","start":"2026-02-11T02:27:08.692762Z","end":"2026-02-11T02:27:08.888221Z","steps":["trace[930304631] 'process raft request' (duration: 195.333278ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:08.888643Z","caller":"traceutil/trace.go:171","msg":"trace[1035044130] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:482; }","duration":"173.544963ms","start":"2026-02-11T02:27:08.715089Z","end":"2026-02-11T02:27:08.888634Z","steps":["trace[1035044130] 'read index received' (duration: 173.541763ms)","trace[1035044130] 'applied index is now lower than readState.Index' (duration: 2.64µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:08.888723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.613465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T02:27:08.888749Z","caller":"traceutil/trace.go:171","msg":"trace[1819749132] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:465; }","duration":"173.716897ms","start":"2026-02-11T02:27:08.715024Z","end":"2026-02-11T02:27:08.888741Z","steps":["trace[1819749132] 'agreement among raft nodes before linearized reading' (duration: 173.654106ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:09.129097Z","caller":"traceutil/trace.go:171","msg":"trace[1577619005] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"240.361762ms","start":"2026-02-11T02:27:08.888666Z","end":"2026-02-11T02:27:09.129028Z","steps":["trace[1577619005] 'read index received' (duration: 193.29264ms)","trace[1577619005] 'applied index is now lower than readState.Index' (duration: 47.066492ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:09.129292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.420574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T02:27:09.129326Z","caller":"traceutil/trace.go:171","msg":"trace[2101144466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:466; }","duration":"413.492666ms","start":"2026-02-11T02:27:08.715823Z","end":"2026-02-11T02:27:09.129316Z","steps":["trace[2101144466] 'agreement among raft nodes before linearized reading' (duration: 413.372043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:09.129357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:08.715813Z","time spent":"413.536197ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-11T02:27:09.129632Z","caller":"traceutil/trace.go:171","msg":"trace[310869835] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"323.621851ms","start":"2026-02-11T02:27:08.805995Z","end":"2026-02-11T02:27:09.129617Z","steps":["trace[310869835] 'process raft request' (duration: 275.951885ms)","trace[310869835] 'compare' (duration: 46.874288ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:09.130723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:08.805978Z","time spent":"323.691382ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:27:09.131972Z","caller":"traceutil/trace.go:171","msg":"trace[173745954] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"239.482482ms","start":"2026-02-11T02:27:08.892481Z","end":"2026-02-11T02:27:09.131963Z","steps":["trace[173745954] 'process raft request' (duration: 239.43233ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:11.398967Z","caller":"traceutil/trace.go:171","msg":"trace[1430800241] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"190.228659ms","start":"2026-02-11T02:27:11.208716Z","end":"2026-02-11T02:27:11.398945Z","steps":["trace[1430800241] 'process raft request' (duration: 177.329233ms)","trace[1430800241] 'compare' (duration: 12.819274ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:18.367619Z","caller":"traceutil/trace.go:171","msg":"trace[1165595591] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"143.470501ms","start":"2026-02-11T02:27:18.224118Z","end":"2026-02-11T02:27:18.367588Z","steps":["trace[1165595591] 'process raft request' (duration: 143.320748ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:19.440441Z","caller":"traceutil/trace.go:171","msg":"trace[1521234177] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"498.124708ms","start":"2026-02-11T02:27:18.942289Z","end":"2026-02-11T02:27:19.440414Z","steps":["trace[1521234177] 'process raft request' (duration: 497.821771ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:19.440811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:18.942265Z","time spent":"498.346724ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:27:22.687759Z","caller":"traceutil/trace.go:171","msg":"trace[2017168097] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"309.819586ms","start":"2026-02-11T02:27:22.37791Z","end":"2026-02-11T02:27:22.68773Z","steps":["trace[2017168097] 'read index received' (duration: 309.618511ms)","trace[2017168097] 'applied index is now lower than readState.Index' (duration: 200.245µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:22.687985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.026731ms","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-11T02:27:22.688019Z","caller":"traceutil/trace.go:171","msg":"trace[896668256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:532; }","duration":"310.137972ms","start":"2026-02-11T02:27:22.377871Z","end":"2026-02-11T02:27:22.688008Z","steps":["trace[896668256] 'agreement among raft nodes before linearized reading' (duration: 309.978599ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:22.688058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:22.377851Z","time spent":"310.196214ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-11T02:27:22.688401Z","caller":"traceutil/trace.go:171","msg":"trace[113488261] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"335.662177ms","start":"2026-02-11T02:27:22.352728Z","end":"2026-02-11T02:27:22.68839Z","steps":["trace[113488261] 'process raft request' (duration: 334.876028ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:22.688482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:22.352703Z","time spent":"335.723178ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:27:25.979969Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5450371817933950876,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-11T02:27:26.186552Z","caller":"traceutil/trace.go:171","msg":"trace[250239264] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"708.129933ms","start":"2026-02-11T02:27:25.478389Z","end":"2026-02-11T02:27:26.186519Z","steps":["trace[250239264] 'process raft request' (duration: 707.907409ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:26.186789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:25.478345Z","time spent":"708.311047ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:27:26.187577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.290806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T02:27:26.187681Z","caller":"traceutil/trace.go:171","msg":"trace[297443700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:538; }","duration":"708.372828ms","start":"2026-02-11T02:27:25.47924Z","end":"2026-02-11T02:27:26.187613Z","steps":["trace[297443700] 'agreement among raft nodes before linearized reading' (duration: 708.295326ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:26.187731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:25.479229Z","time spent":"708.493681ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-11T02:27:26.187481Z","caller":"traceutil/trace.go:171","msg":"trace[2111762892] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:559; }","duration":"708.148223ms","start":"2026-02-11T02:27:25.479279Z","end":"2026-02-11T02:27:26.187427Z","steps":["trace[2111762892] 'read index received' (duration: 708.141463ms)","trace[2111762892] 'applied index is now lower than readState.Index' (duration: 5.25µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:26.188111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.598655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:27:26.188141Z","caller":"traceutil/trace.go:171","msg":"trace[1569512571] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:538; }","duration":"195.653986ms","start":"2026-02-11T02:27:25.992477Z","end":"2026-02-11T02:27:26.188131Z","steps":["trace[1569512571] 'agreement among raft nodes before linearized reading' (duration: 195.593474ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:26.188567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.011584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T02:27:26.188747Z","caller":"traceutil/trace.go:171","msg":"trace[434244087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:538; }","duration":"646.116306ms","start":"2026-02-11T02:27:25.542503Z","end":"2026-02-11T02:27:26.188619Z","steps":["trace[434244087] 'agreement among raft nodes before linearized reading' (duration: 645.544443ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:26.192485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:25.542482Z","time spent":"646.352052ms","remote":"127.0.0.1:60902","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-11T02:27:26.939211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.910029ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:27:26.93934Z","caller":"traceutil/trace.go:171","msg":"trace[1926831892] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:538; }","duration":"217.061903ms","start":"2026-02-11T02:27:26.72226Z","end":"2026-02-11T02:27:26.939322Z","steps":["trace[1926831892] 'range keys from in-memory index tree' (duration: 216.892328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:26.941059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.540154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:27:26.941342Z","caller":"traceutil/trace.go:171","msg":"trace[185535012] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"748.778505ms","start":"2026-02-11T02:27:26.192551Z","end":"2026-02-11T02:27:26.941329Z","steps":["trace[185535012] 'process raft request' (duration: 485.121641ms)","trace[185535012] 'compare' (duration: 261.38689ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:26.941431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:26.192539Z","time spent":"748.862008ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:27:26.941682Z","caller":"traceutil/trace.go:171","msg":"trace[450038220] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"744.691018ms","start":"2026-02-11T02:27:26.196985Z","end":"2026-02-11T02:27:26.941676Z","steps":["trace[450038220] 'process raft request' (duration: 744.288559ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:26.941718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:26.196964Z","time spent":"744.736019ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:27:26.941953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.483374ms","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-11T02:27:26.941975Z","caller":"traceutil/trace.go:171","msg":"trace[1696311744] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:540; }","duration":"190.544035ms","start":"2026-02-11T02:27:26.751423Z","end":"2026-02-11T02:27:26.941967Z","steps":["trace[1696311744] 'agreement among raft nodes before linearized reading' (duration: 190.451753ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:26.941352Z","caller":"traceutil/trace.go:171","msg":"trace[772828104] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:559; }","duration":"189.866339ms","start":"2026-02-11T02:27:26.751472Z","end":"2026-02-11T02:27:26.941338Z","steps":["trace[772828104] 'read index received' (duration: 123.338907ms)","trace[772828104] 'applied index is now lower than readState.Index' (duration: 66.526312ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:32.685957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.887671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-11T02:27:32.686388Z","caller":"traceutil/trace.go:171","msg":"trace[1328712717] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:614; }","duration":"281.468506ms","start":"2026-02-11T02:27:32.404896Z","end":"2026-02-11T02:27:32.686365Z","steps":["trace[1328712717] 'range keys from in-memory index tree' (duration: 280.583394ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:32.735142Z","caller":"traceutil/trace.go:171","msg":"trace[9190941] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"219.338346ms","start":"2026-02-11T02:27:32.51579Z","end":"2026-02-11T02:27:32.735129Z","steps":["trace[9190941] 'process raft request' (duration: 218.996868ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:32.899444Z","caller":"traceutil/trace.go:171","msg":"trace[1196548383] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"294.291939ms","start":"2026-02-11T02:27:32.605131Z","end":"2026-02-11T02:27:32.899423Z","steps":["trace[1196548383] 'process raft request' (duration: 290.883138ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:32.899791Z","caller":"traceutil/trace.go:171","msg":"trace[1015431436] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"173.81553ms","start":"2026-02-11T02:27:32.725962Z","end":"2026-02-11T02:27:32.899778Z","steps":["trace[1015431436] 'process raft request' (duration: 173.261847ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:34.020261Z","caller":"traceutil/trace.go:171","msg":"trace[162692683] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"119.973746ms","start":"2026-02-11T02:27:33.900274Z","end":"2026-02-11T02:27:34.020248Z","steps":["trace[162692683] 'process raft request' (duration: 119.26139ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:34.441111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.396734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-t6p2q\" ","response":"range_response_count:1 size:18075"} {"level":"info","ts":"2026-02-11T02:27:34.441198Z","caller":"traceutil/trace.go:171","msg":"trace[391097210] range","detail":"{range_begin:/registry/pods/kube-system/cilium-t6p2q; range_end:; response_count:1; response_revision:628; }","duration":"133.515006ms","start":"2026-02-11T02:27:34.307659Z","end":"2026-02-11T02:27:34.441174Z","steps":["trace[391097210] 'range keys from in-memory index tree' (duration: 133.200828ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:34.44171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.811281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-02-11T02:27:34.441746Z","caller":"traceutil/trace.go:171","msg":"trace[1245963855] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:628; }","duration":"239.878072ms","start":"2026-02-11T02:27:34.201856Z","end":"2026-02-11T02:27:34.441734Z","steps":["trace[1245963855] 'range keys from in-memory index tree' (duration: 239.591965ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:34.442145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.434437ms","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-11T02:27:34.442185Z","caller":"traceutil/trace.go:171","msg":"trace[449254367] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:628; }","duration":"194.474488ms","start":"2026-02-11T02:27:34.247698Z","end":"2026-02-11T02:27:34.442172Z","steps":["trace[449254367] 'range keys from in-memory index tree' (duration: 194.273753ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:37.171617Z","caller":"traceutil/trace.go:171","msg":"trace[998532489] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"134.334456ms","start":"2026-02-11T02:27:37.037257Z","end":"2026-02-11T02:27:37.171591Z","steps":["trace[998532489] 'process raft request' (duration: 133.827734ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:38.397086Z","caller":"traceutil/trace.go:171","msg":"trace[2090578474] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"392.161262ms","start":"2026-02-11T02:27:38.004904Z","end":"2026-02-11T02:27:38.397066Z","steps":["trace[2090578474] 'read index received' (duration: 391.925706ms)","trace[2090578474] 'applied index is now lower than readState.Index' (duration: 234.736µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:38.39719Z","caller":"traceutil/trace.go:171","msg":"trace[1658506643] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"392.294466ms","start":"2026-02-11T02:27:38.004888Z","end":"2026-02-11T02:27:38.397182Z","steps":["trace[1658506643] 'process raft request' (duration: 392.013429ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:38.397326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:38.004878Z","time spent":"392.336437ms","remote":"127.0.0.1:60808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18235,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:27:38.39741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.945159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T02:27:38.397487Z","caller":"traceutil/trace.go:171","msg":"trace[1519658827] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:648; }","duration":"343.031541ms","start":"2026-02-11T02:27:38.054412Z","end":"2026-02-11T02:27:38.397444Z","steps":["trace[1519658827] 'agreement among raft nodes before linearized reading' (duration: 342.901388ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:38.397514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:38.054399Z","time spent":"343.108433ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-11T02:27:38.397569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.662784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:27:38.397606Z","caller":"traceutil/trace.go:171","msg":"trace[71230554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"392.725606ms","start":"2026-02-11T02:27:38.004875Z","end":"2026-02-11T02:27:38.3976Z","steps":["trace[71230554] 'agreement among raft nodes before linearized reading' (duration: 392.670184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:38.397636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:38.00486Z","time spent":"392.771787ms","remote":"127.0.0.1:60672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T02:27:39.62858Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5450371817933951128,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-11T02:27:39.711504Z","caller":"traceutil/trace.go:171","msg":"trace[273980147] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"613.573467ms","start":"2026-02-11T02:27:39.097918Z","end":"2026-02-11T02:27:39.711492Z","steps":["trace[273980147] 'process raft request' (duration: 613.493145ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:39.711611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:39.097903Z","time spent":"613.642308ms","remote":"127.0.0.1:42786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2262,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T02:27:39.711887Z","caller":"traceutil/trace.go:171","msg":"trace[611745123] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:690; }","duration":"583.613968ms","start":"2026-02-11T02:27:39.128264Z","end":"2026-02-11T02:27:39.711878Z","steps":["trace[611745123] 'read index received' (duration: 583.099236ms)","trace[611745123] 'applied index is now lower than readState.Index' (duration: 514.182µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:39.71209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.821263ms","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-11T02:27:39.712121Z","caller":"traceutil/trace.go:171","msg":"trace[1016045158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:668; }","duration":"583.869395ms","start":"2026-02-11T02:27:39.128237Z","end":"2026-02-11T02:27:39.712106Z","steps":["trace[1016045158] 'agreement among raft nodes before linearized reading' (duration: 583.796633ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:39.712139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:39.128226Z","time spent":"583.909465ms","remote":"127.0.0.1:60902","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-11T02:27:39.712235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.590594ms","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-11T02:27:39.712252Z","caller":"traceutil/trace.go:171","msg":"trace[1291696786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:668; }","duration":"535.633015ms","start":"2026-02-11T02:27:39.176616Z","end":"2026-02-11T02:27:39.712249Z","steps":["trace[1291696786] 'agreement among raft nodes before linearized reading' (duration: 535.580124ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:39.712267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:39.176573Z","time spent":"535.691136ms","remote":"127.0.0.1:60902","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-11T02:27:39.712425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.447401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-11T02:27:39.712444Z","caller":"traceutil/trace.go:171","msg":"trace[186690530] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:668; }","duration":"497.483342ms","start":"2026-02-11T02:27:39.214955Z","end":"2026-02-11T02:27:39.712439Z","steps":["trace[186690530] 'agreement among raft nodes before linearized reading' (duration: 497.442441ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:39.712457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:39.214942Z","time spent":"497.512383ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-11T02:27:39.713553Z","caller":"traceutil/trace.go:171","msg":"trace[666577711] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"609.237544ms","start":"2026-02-11T02:27:39.102654Z","end":"2026-02-11T02:27:39.711891Z","steps":["trace[666577711] 'process raft request' (duration: 609.172083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:39.713671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:39.102647Z","time spent":"610.977646ms","remote":"127.0.0.1:42786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2262,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T02:27:41.682774Z","caller":"traceutil/trace.go:171","msg":"trace[265822430] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"303.206508ms","start":"2026-02-11T02:27:41.379551Z","end":"2026-02-11T02:27:41.682757Z","steps":["trace[265822430] 'process raft request' (duration: 216.830836ms)","trace[265822430] 'compare' (duration: 86.121976ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:41.68287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:41.379521Z","time spent":"303.300411ms","remote":"127.0.0.1:60914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1298,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:27:42.731985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.858114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:27:42.732052Z","caller":"traceutil/trace.go:171","msg":"trace[1947730798] linearizableReadLoop","detail":"{readStateIndex:716; appliedIndex:715; }","duration":"1.001475928s","start":"2026-02-11T02:27:41.730564Z","end":"2026-02-11T02:27:42.73204Z","steps":["trace[1947730798] 'read index received' (duration: 93.45896ms)","trace[1947730798] 'applied index is now lower than readState.Index' (duration: 908.016168ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:42.732196Z","caller":"traceutil/trace.go:171","msg":"trace[3452265] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"1.349683551s","start":"2026-02-11T02:27:41.382505Z","end":"2026-02-11T02:27:42.732189Z","steps":["trace[3452265] 'process raft request' (duration: 441.561761ms)","trace[3452265] 'compare' (duration: 907.571988ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:42.732252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:41.382498Z","time spent":"1.349715682s","remote":"127.0.0.1:60808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4794,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:27:42.732438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.001872837s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-11T02:27:42.732459Z","caller":"traceutil/trace.go:171","msg":"trace[1770103517] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:690; }","duration":"1.001917548s","start":"2026-02-11T02:27:41.730534Z","end":"2026-02-11T02:27:42.732451Z","steps":["trace[1770103517] 'agreement among raft nodes before linearized reading' (duration: 1.001838827s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:42.732476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:41.73052Z","time spent":"1.001952199s","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T02:27:42.732594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.829389ms","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-11T02:27:42.73261Z","caller":"traceutil/trace.go:171","msg":"trace[342523382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:690; }","duration":"996.854879ms","start":"2026-02-11T02:27:41.73575Z","end":"2026-02-11T02:27:42.732605Z","steps":["trace[342523382] 'agreement among raft nodes before linearized reading' (duration: 996.807078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:42.73263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:41.735744Z","time spent":"996.88246ms","remote":"127.0.0.1:60902","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-11T02:27:42.73288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.495131ms","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-11T02:27:42.732898Z","caller":"traceutil/trace.go:171","msg":"trace[6370797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:690; }","duration":"214.552062ms","start":"2026-02-11T02:27:42.518341Z","end":"2026-02-11T02:27:42.732893Z","steps":["trace[6370797] 'agreement among raft nodes before linearized reading' (duration: 214.505861ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:42.732976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.333127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:27:42.732991Z","caller":"traceutil/trace.go:171","msg":"trace[1435818490] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:690; }","duration":"741.386088ms","start":"2026-02-11T02:27:41.991601Z","end":"2026-02-11T02:27:42.732987Z","steps":["trace[1435818490] 'agreement among raft nodes before linearized reading' (duration: 741.362828ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:42.733006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:41.991536Z","time spent":"741.466571ms","remote":"127.0.0.1:60668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T02:27:42.733102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.32101ms","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-11T02:27:42.733116Z","caller":"traceutil/trace.go:171","msg":"trace[221601047] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:690; }","duration":"997.34169ms","start":"2026-02-11T02:27:41.73577Z","end":"2026-02-11T02:27:42.733112Z","steps":["trace[221601047] 'agreement among raft nodes before linearized reading' (duration: 997.301269ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:42.733131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:41.735768Z","time spent":"997.359921ms","remote":"127.0.0.1:60902","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":"info","ts":"2026-02-11T02:27:42.981201Z","caller":"traceutil/trace.go:171","msg":"trace[236288146] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"226.890534ms","start":"2026-02-11T02:27:42.754291Z","end":"2026-02-11T02:27:42.981182Z","steps":["trace[236288146] 'process raft request' (duration: 226.808572ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.981355Z","caller":"traceutil/trace.go:171","msg":"trace[1018213674] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"227.092639ms","start":"2026-02-11T02:27:42.754237Z","end":"2026-02-11T02:27:42.98133Z","steps":["trace[1018213674] 'process raft request' (duration: 226.766481ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.981553Z","caller":"traceutil/trace.go:171","msg":"trace[1452682706] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"222.292535ms","start":"2026-02-11T02:27:42.759249Z","end":"2026-02-11T02:27:42.981542Z","steps":["trace[1452682706] 'process raft request' (duration: 221.910876ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.981979Z","caller":"traceutil/trace.go:171","msg":"trace[242653391] linearizableReadLoop","detail":"{readStateIndex:723; appliedIndex:717; }","duration":"222.340086ms","start":"2026-02-11T02:27:42.759626Z","end":"2026-02-11T02:27:42.981966Z","steps":["trace[242653391] 'read index received' (duration: 54.522678ms)","trace[242653391] 'applied index is now lower than readState.Index' (duration: 167.816668ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:42.982099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.445529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-pwkxj\" ","response":"range_response_count:1 size:5026"} {"level":"info","ts":"2026-02-11T02:27:42.982121Z","caller":"traceutil/trace.go:171","msg":"trace[243752879] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-pwkxj; range_end:; response_count:1; response_revision:698; }","duration":"222.509791ms","start":"2026-02-11T02:27:42.759604Z","end":"2026-02-11T02:27:42.982114Z","steps":["trace[243752879] 'agreement among raft nodes before linearized reading' (duration: 222.404198ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.982131Z","caller":"traceutil/trace.go:171","msg":"trace[1180042016] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"222.717035ms","start":"2026-02-11T02:27:42.759405Z","end":"2026-02-11T02:27:42.982122Z","steps":["trace[1180042016] 'process raft request' (duration: 222.449909ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.982237Z","caller":"traceutil/trace.go:171","msg":"trace[1162015954] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"222.653124ms","start":"2026-02-11T02:27:42.759578Z","end":"2026-02-11T02:27:42.982231Z","steps":["trace[1162015954] 'process raft request' (duration: 222.336526ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.982241Z","caller":"traceutil/trace.go:171","msg":"trace[971134830] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"222.90495ms","start":"2026-02-11T02:27:42.759329Z","end":"2026-02-11T02:27:42.982234Z","steps":["trace[971134830] 'process raft request' (duration: 222.189893ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.982373Z","caller":"traceutil/trace.go:171","msg":"trace[128062973] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"221.853386ms","start":"2026-02-11T02:27:42.760512Z","end":"2026-02-11T02:27:42.982365Z","steps":["trace[128062973] 'process raft request' (duration: 221.429536ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:50.146133Z","caller":"traceutil/trace.go:171","msg":"trace[580730581] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"141.493132ms","start":"2026-02-11T02:27:50.004617Z","end":"2026-02-11T02:27:50.14611Z","steps":["trace[580730581] 'process raft request' (duration: 73.423939ms)","trace[580730581] 'compare' (duration: 67.810737ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:51.19558Z","caller":"traceutil/trace.go:171","msg":"trace[1615913810] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"181.734326ms","start":"2026-02-11T02:27:51.013828Z","end":"2026-02-11T02:27:51.195563Z","steps":["trace[1615913810] 'process raft request' (duration: 181.631433ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:51.377665Z","caller":"traceutil/trace.go:171","msg":"trace[1567716071] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"362.764184ms","start":"2026-02-11T02:27:51.014893Z","end":"2026-02-11T02:27:51.377657Z","steps":["trace[1567716071] 'process raft request' (duration: 362.429006ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:51.377765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:51.014887Z","time spent":"362.821076ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:27:51.377437Z","caller":"traceutil/trace.go:171","msg":"trace[1914231268] linearizableReadLoop","detail":"{readStateIndex:769; appliedIndex:768; }","duration":"329.885386ms","start":"2026-02-11T02:27:51.047536Z","end":"2026-02-11T02:27:51.377421Z","steps":["trace[1914231268] 'read index received' (duration: 148.470388ms)","trace[1914231268] 'applied index is now lower than readState.Index' (duration: 181.414108ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:51.378115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.575882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T02:27:51.378139Z","caller":"traceutil/trace.go:171","msg":"trace[1680602726] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:741; }","duration":"330.635064ms","start":"2026-02-11T02:27:51.047497Z","end":"2026-02-11T02:27:51.378132Z","steps":["trace[1680602726] 'agreement among raft nodes before linearized reading' (duration: 330.546852ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:51.378158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:51.047482Z","time spent":"330.672155ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-11T02:27:51.380948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.789759ms","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-11T02:27:51.380971Z","caller":"traceutil/trace.go:171","msg":"trace[885105598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:741; }","duration":"314.83503ms","start":"2026-02-11T02:27:51.066131Z","end":"2026-02-11T02:27:51.380966Z","steps":["trace[885105598] 'agreement among raft nodes before linearized reading' (duration: 314.767338ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:51.381021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.141623ms","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-11T02:27:51.381037Z","caller":"traceutil/trace.go:171","msg":"trace[767634257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:741; }","duration":"314.166224ms","start":"2026-02-11T02:27:51.066867Z","end":"2026-02-11T02:27:51.381033Z","steps":["trace[767634257] 'agreement among raft nodes before linearized reading' (duration: 314.128573ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:51.381048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:51.066862Z","time spent":"314.183244ms","remote":"127.0.0.1:60902","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-11T02:27:51.381339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:51.066119Z","time spent":"314.86344ms","remote":"127.0.0.1:60902","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-11T02:28:08.192301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.193583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:28:08.192375Z","caller":"traceutil/trace.go:171","msg":"trace[1801581944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"197.346617ms","start":"2026-02-11T02:28:07.995012Z","end":"2026-02-11T02:28:08.192358Z","steps":["trace[1801581944] 'range keys from in-memory index tree' (duration: 197.133671ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:09.659584Z","caller":"traceutil/trace.go:171","msg":"trace[180397661] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"200.04112ms","start":"2026-02-11T02:28:09.459522Z","end":"2026-02-11T02:28:09.659563Z","steps":["trace[180397661] 'process raft request' (duration: 199.698212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:10.409654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.780943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:28:10.409757Z","caller":"traceutil/trace.go:171","msg":"trace[484915423] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"741.026427ms","start":"2026-02-11T02:28:09.668715Z","end":"2026-02-11T02:28:10.409741Z","steps":["trace[484915423] 'process raft request' (duration: 522.09703ms)","trace[484915423] 'compare' (duration: 218.689821ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:28:10.409814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:09.668702Z","time spent":"741.090968ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:28:10.410486Z","caller":"traceutil/trace.go:171","msg":"trace[630140357] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:827; }","duration":"558.146855ms","start":"2026-02-11T02:28:09.85232Z","end":"2026-02-11T02:28:10.410467Z","steps":["trace[630140357] 'read index received' (duration: 338.456179ms)","trace[630140357] 'applied index is now lower than readState.Index' (duration: 219.689856ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:28:10.410733Z","caller":"traceutil/trace.go:171","msg":"trace[380647863] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"741.921539ms","start":"2026-02-11T02:28:09.668795Z","end":"2026-02-11T02:28:10.410716Z","steps":["trace[380647863] 'process raft request' (duration: 741.55613ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:10.410871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:09.668776Z","time spent":"742.024031ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:28:10.411071Z","caller":"traceutil/trace.go:171","msg":"trace[966428523] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"742.206924ms","start":"2026-02-11T02:28:09.668855Z","end":"2026-02-11T02:28:10.411062Z","steps":["trace[966428523] 'process raft request' (duration: 741.57848ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:10.411126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:09.66885Z","time spent":"742.247496ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:28:10.411319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.002194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.220\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-11T02:28:10.411357Z","caller":"traceutil/trace.go:171","msg":"trace[6448721] range","detail":"{range_begin:/registry/masterleases/199.19.213.220; range_end:; response_count:1; response_revision:799; }","duration":"559.075256ms","start":"2026-02-11T02:28:09.85227Z","end":"2026-02-11T02:28:10.411345Z","steps":["trace[6448721] 'agreement among raft nodes before linearized reading' (duration: 558.946143ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:10.411386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:09.852247Z","time spent":"559.131948ms","remote":"127.0.0.1:60678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.220\" "} {"level":"warn","ts":"2026-02-11T02:28:10.411943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.13314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T02:28:10.411976Z","caller":"traceutil/trace.go:171","msg":"trace[820711352] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:799; }","duration":"530.170531ms","start":"2026-02-11T02:28:09.881797Z","end":"2026-02-11T02:28:10.411967Z","steps":["trace[820711352] 'agreement among raft nodes before linearized reading' (duration: 530.11718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:10.412004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:09.881737Z","time spent":"530.259813ms","remote":"127.0.0.1:60806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":29,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-02-11T02:28:10.421604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.817057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:28:10.421641Z","caller":"traceutil/trace.go:171","msg":"trace[1718020274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:799; }","duration":"427.886898ms","start":"2026-02-11T02:28:09.993745Z","end":"2026-02-11T02:28:10.421632Z","steps":["trace[1718020274] 'agreement among raft nodes before linearized reading' (duration: 427.827967ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:10.421662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:09.993724Z","time spent":"427.933619ms","remote":"127.0.0.1:60672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T02:28:10.421767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.194187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T02:28:10.421786Z","caller":"traceutil/trace.go:171","msg":"trace[1448150622] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:799; }","duration":"393.245468ms","start":"2026-02-11T02:28:10.028534Z","end":"2026-02-11T02:28:10.42178Z","steps":["trace[1448150622] 'agreement among raft nodes before linearized reading' (duration: 393.212017ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:10.421805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:10.028501Z","time spent":"393.298659ms","remote":"127.0.0.1:60896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-02-11T02:28:10.42262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.126486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T02:28:10.422649Z","caller":"traceutil/trace.go:171","msg":"trace[666080512] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:799; }","duration":"333.501552ms","start":"2026-02-11T02:28:10.089138Z","end":"2026-02-11T02:28:10.42264Z","steps":["trace[666080512] 'agreement among raft nodes before linearized reading' (duration: 323.165627ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:10.422674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:10.089118Z","time spent":"333.548363ms","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":4,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-02-11T02:28:10.641614Z","caller":"traceutil/trace.go:171","msg":"trace[2093511434] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"188.166289ms","start":"2026-02-11T02:28:10.453418Z","end":"2026-02-11T02:28:10.641584Z","steps":["trace[2093511434] 'process raft request' (duration: 108.281357ms)","trace[2093511434] 'compare' (duration: 78.735705ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:28:10.642317Z","caller":"traceutil/trace.go:171","msg":"trace[1094606580] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"111.84411ms","start":"2026-02-11T02:28:10.530455Z","end":"2026-02-11T02:28:10.642299Z","steps":["trace[1094606580] 'process raft request' (duration: 110.204361ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:25.42998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.530949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:28:25.430035Z","caller":"traceutil/trace.go:171","msg":"trace[8394732] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:897; }","duration":"435.697873ms","start":"2026-02-11T02:28:24.994325Z","end":"2026-02-11T02:28:25.430023Z","steps":["trace[8394732] 'agreement among raft nodes before linearized reading' (duration: 19.156863ms)","trace[8394732] 'range keys from in-memory index tree' (duration: 415.759182ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:28:25.430056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:24.994306Z","time spent":"435.745995ms","remote":"127.0.0.1:60668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T02:28:25.43016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.983864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T02:28:25.430173Z","caller":"traceutil/trace.go:171","msg":"trace[176123101] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:897; }","duration":"369.018244ms","start":"2026-02-11T02:28:25.061151Z","end":"2026-02-11T02:28:25.430169Z","steps":["trace[176123101] 'count revisions from in-memory index tree' (duration: 368.916311ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:25.430191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:25.061139Z","time spent":"369.042844ms","remote":"127.0.0.1:32876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":29,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-02-11T02:28:25.430751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.177927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:28:25.430799Z","caller":"traceutil/trace.go:171","msg":"trace[704569982] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:897; }","duration":"250.264139ms","start":"2026-02-11T02:28:25.180523Z","end":"2026-02-11T02:28:25.430787Z","steps":["trace[704569982] 'count revisions from in-memory index tree' (duration: 250.131356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:26.011364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.509179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T02:28:26.011411Z","caller":"traceutil/trace.go:171","msg":"trace[458836809] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:898; }","duration":"297.57006ms","start":"2026-02-11T02:28:25.71383Z","end":"2026-02-11T02:28:26.0114Z","steps":["trace[458836809] 'range keys from in-memory index tree' (duration: 297.392677ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:26.23132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.132921ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-11T02:28:26.232Z","caller":"traceutil/trace.go:171","msg":"trace[1496993526] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"217.456871ms","start":"2026-02-11T02:28:26.014526Z","end":"2026-02-11T02:28:26.231982Z","steps":["trace[1496993526] 'process raft request' (duration: 216.896318ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:28.657922Z","caller":"traceutil/trace.go:171","msg":"trace[1384788226] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:941; }","duration":"171.037892ms","start":"2026-02-11T02:28:28.486858Z","end":"2026-02-11T02:28:28.657895Z","steps":["trace[1384788226] 'read index received' (duration: 170.828987ms)","trace[1384788226] 'applied index is now lower than readState.Index' (duration: 208.015µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:28:28.658275Z","caller":"traceutil/trace.go:171","msg":"trace[1430590784] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"176.722818ms","start":"2026-02-11T02:28:28.481526Z","end":"2026-02-11T02:28:28.658249Z","steps":["trace[1430590784] 'process raft request' (duration: 176.229686ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:28.658391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.052956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T02:28:28.658434Z","caller":"traceutil/trace.go:171","msg":"trace[1623639636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:905; }","duration":"169.119207ms","start":"2026-02-11T02:28:28.489301Z","end":"2026-02-11T02:28:28.658421Z","steps":["trace[1623639636] 'agreement among raft nodes before linearized reading' (duration: 168.970723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:28.658591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.728828ms","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-11T02:28:28.658617Z","caller":"traceutil/trace.go:171","msg":"trace[1855972495] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:905; }","duration":"171.770469ms","start":"2026-02-11T02:28:28.486838Z","end":"2026-02-11T02:28:28.658609Z","steps":["trace[1855972495] 'agreement among raft nodes before linearized reading' (duration: 171.693228ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:28.893836Z","caller":"traceutil/trace.go:171","msg":"trace[1924973661] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"231.28362ms","start":"2026-02-11T02:28:28.662534Z","end":"2026-02-11T02:28:28.893818Z","steps":["trace[1924973661] 'process raft request' (duration: 172.984848ms)","trace[1924973661] 'compare' (duration: 58.21815ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:28:29.023469Z","caller":"traceutil/trace.go:171","msg":"trace[227175205] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"359.778494ms","start":"2026-02-11T02:28:28.66367Z","end":"2026-02-11T02:28:29.023449Z","steps":["trace[227175205] 'process raft request' (duration: 333.41047ms)","trace[227175205] 'compare' (duration: 26.106328ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:28:29.023556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:28.663655Z","time spent":"359.854296ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:28:32.618279Z","caller":"traceutil/trace.go:171","msg":"trace[1828110390] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"359.080878ms","start":"2026-02-11T02:28:32.259158Z","end":"2026-02-11T02:28:32.618239Z","steps":["trace[1828110390] 'process raft request' (duration: 358.917004ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:32.618425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:32.25915Z","time spent":"359.19085ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:28:32.781048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.350781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T02:28:32.781096Z","caller":"traceutil/trace.go:171","msg":"trace[1354831667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:916; }","duration":"112.429904ms","start":"2026-02-11T02:28:32.668654Z","end":"2026-02-11T02:28:32.781084Z","steps":["trace[1354831667] 'range keys from in-memory index tree' (duration: 112.23447ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:32.88622Z","caller":"traceutil/trace.go:171","msg":"trace[1371555539] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"102.214781ms","start":"2026-02-11T02:28:32.783988Z","end":"2026-02-11T02:28:32.886203Z","steps":["trace[1371555539] 'process raft request' (duration: 102.119519ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:35.167077Z","caller":"traceutil/trace.go:171","msg":"trace[15054997] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"122.122803ms","start":"2026-02-11T02:28:35.044939Z","end":"2026-02-11T02:28:35.167062Z","steps":["trace[15054997] 'process raft request' (duration: 121.98837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:36.148434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.941057ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-11T02:28:36.148512Z","caller":"traceutil/trace.go:171","msg":"trace[656382281] linearizableReadLoop","detail":"{readStateIndex:964; appliedIndex:963; }","duration":"785.235724ms","start":"2026-02-11T02:28:35.363263Z","end":"2026-02-11T02:28:36.148499Z","steps":["trace[656382281] 'read index received' (duration: 90.151904ms)","trace[656382281] 'applied index is now lower than readState.Index' (duration: 695.08282ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:28:36.148756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.48477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T02:28:36.148777Z","caller":"traceutil/trace.go:171","msg":"trace[1046702097] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:925; }","duration":"785.554032ms","start":"2026-02-11T02:28:35.363216Z","end":"2026-02-11T02:28:36.14877Z","steps":["trace[1046702097] 'agreement among raft nodes before linearized reading' (duration: 785.49779ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:36.1488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:35.363195Z","time spent":"785.597063ms","remote":"127.0.0.1:32814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-02-11T02:28:36.148975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.317965ms","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-11T02:28:36.149004Z","caller":"traceutil/trace.go:171","msg":"trace[1025436857] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:925; }","duration":"519.360666ms","start":"2026-02-11T02:28:35.629626Z","end":"2026-02-11T02:28:36.148987Z","steps":["trace[1025436857] 'agreement among raft nodes before linearized reading' (duration: 519.285804ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:36.149021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:35.629611Z","time spent":"519.405847ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-11T02:28:36.298227Z","caller":"traceutil/trace.go:171","msg":"trace[1932370538] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"145.565559ms","start":"2026-02-11T02:28:36.152643Z","end":"2026-02-11T02:28:36.298209Z","steps":["trace[1932370538] 'process raft request' (duration: 145.454266ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:52.761174Z","caller":"traceutil/trace.go:171","msg":"trace[442186849] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"110.406159ms","start":"2026-02-11T02:28:52.650577Z","end":"2026-02-11T02:28:52.760983Z","steps":["trace[442186849] 'process raft request' (duration: 110.291247ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:52.97079Z","caller":"traceutil/trace.go:171","msg":"trace[384132873] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"195.8246ms","start":"2026-02-11T02:28:52.773964Z","end":"2026-02-11T02:28:52.969788Z","steps":["trace[384132873] 'process raft request' (duration: 193.198788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:56.420605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.817879ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-11T02:28:56.420757Z","caller":"traceutil/trace.go:171","msg":"trace[1133409983] linearizableReadLoop","detail":"{readStateIndex:1084; appliedIndex:1083; }","duration":"1.154207759s","start":"2026-02-11T02:28:55.266522Z","end":"2026-02-11T02:28:56.42073Z","steps":["trace[1133409983] 'read index received' (duration: 456.177945ms)","trace[1133409983] 'applied index is now lower than readState.Index' (duration: 698.027913ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:28:56.421031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.128935141s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T02:28:56.421114Z","caller":"traceutil/trace.go:171","msg":"trace[1322873015] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1041; }","duration":"1.129063724s","start":"2026-02-11T02:28:55.292028Z","end":"2026-02-11T02:28:56.421092Z","steps":["trace[1322873015] 'agreement among raft nodes before linearized reading' (duration: 1.128921651s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:56.42116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:55.292012Z","time spent":"1.129137176s","remote":"127.0.0.1:42824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":2,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-02-11T02:28:56.421608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.048176641s","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-11T02:28:56.421646Z","caller":"traceutil/trace.go:171","msg":"trace[1386528277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1041; }","duration":"1.048235002s","start":"2026-02-11T02:28:55.373399Z","end":"2026-02-11T02:28:56.421634Z","steps":["trace[1386528277] 'agreement among raft nodes before linearized reading' (duration: 1.04809466s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:56.421678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:55.373389Z","time spent":"1.048280093s","remote":"127.0.0.1:60902","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-11T02:28:56.42174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.486479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:28:56.421782Z","caller":"traceutil/trace.go:171","msg":"trace[51411067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1041; }","duration":"425.583191ms","start":"2026-02-11T02:28:55.996187Z","end":"2026-02-11T02:28:56.421771Z","steps":["trace[51411067] 'agreement among raft nodes before linearized reading' (duration: 424.921757ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:56.42182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:55.996165Z","time spent":"425.643613ms","remote":"127.0.0.1:60668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T02:28:56.421901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061030755s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-11T02:28:56.421942Z","caller":"traceutil/trace.go:171","msg":"trace[563851521] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1041; }","duration":"1.061098227s","start":"2026-02-11T02:28:55.360833Z","end":"2026-02-11T02:28:56.421931Z","steps":["trace[563851521] 'agreement among raft nodes before linearized reading' (duration: 1.061004095s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:56.421973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:55.360816Z","time spent":"1.061148078s","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-02-11T02:28:56.422184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155694073s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-02-11T02:28:56.422224Z","caller":"traceutil/trace.go:171","msg":"trace[335409458] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1041; }","duration":"1.155767985s","start":"2026-02-11T02:28:55.266442Z","end":"2026-02-11T02:28:56.42221Z","steps":["trace[335409458] 'agreement among raft nodes before linearized reading' (duration: 1.155610041s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:56.422253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:55.266392Z","time spent":"1.155854567s","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-02-11T02:28:56.712721Z","caller":"traceutil/trace.go:171","msg":"trace[1568175765] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"278.252079ms","start":"2026-02-11T02:28:56.434436Z","end":"2026-02-11T02:28:56.712689Z","steps":["trace[1568175765] 'process raft request' (duration: 277.970752ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:56.761572Z","caller":"traceutil/trace.go:171","msg":"trace[1790224899] linearizableReadLoop","detail":"{readStateIndex:1087; appliedIndex:1085; }","duration":"263.476468ms","start":"2026-02-11T02:28:56.498066Z","end":"2026-02-11T02:28:56.761543Z","steps":["trace[1790224899] 'read index received' (duration: 215.781091ms)","trace[1790224899] 'applied index is now lower than readState.Index' (duration: 47.694327ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:28:56.762725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.619986ms","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-11T02:28:56.764868Z","caller":"traceutil/trace.go:171","msg":"trace[139191579] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1044; }","duration":"266.822248ms","start":"2026-02-11T02:28:56.497992Z","end":"2026-02-11T02:28:56.764815Z","steps":["trace[139191579] 'agreement among raft nodes before linearized reading' (duration: 264.408581ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:56.762837Z","caller":"traceutil/trace.go:171","msg":"trace[286955086] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"325.731911ms","start":"2026-02-11T02:28:56.437079Z","end":"2026-02-11T02:28:56.762811Z","steps":["trace[286955086] 'process raft request' (duration: 308.085034ms)","trace[286955086] 'compare' (duration: 15.779222ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:28:56.765598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:56.437053Z","time spent":"328.341793ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:28:56.763001Z","caller":"traceutil/trace.go:171","msg":"trace[803080747] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"325.839653ms","start":"2026-02-11T02:28:56.437146Z","end":"2026-02-11T02:28:56.762985Z","steps":["trace[803080747] 'process raft request' (duration: 324.334667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:56.765999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:28:56.43714Z","time spent":"328.824874ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:32:08.20923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.330314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:32:08.209312Z","caller":"traceutil/trace.go:171","msg":"trace[15239702] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1938; }","duration":"124.685591ms","start":"2026-02-11T02:32:08.084616Z","end":"2026-02-11T02:32:08.209302Z","steps":["trace[15239702] 'read index received' (duration: 28.351µs)","trace[15239702] 'applied index is now lower than readState.Index' (duration: 124.65644ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:32:08.209471Z","caller":"traceutil/trace.go:171","msg":"trace[1719517978] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"200.866791ms","start":"2026-02-11T02:32:08.008595Z","end":"2026-02-11T02:32:08.209462Z","steps":["trace[1719517978] 'process raft request' (duration: 57.139449ms)","trace[1719517978] 'compare' (duration: 143.235911ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:32:08.209638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.019818ms","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-11T02:32:08.209655Z","caller":"traceutil/trace.go:171","msg":"trace[32946141] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1857; }","duration":"125.07068ms","start":"2026-02-11T02:32:08.084579Z","end":"2026-02-11T02:32:08.20965Z","steps":["trace[32946141] 'agreement among raft nodes before linearized reading' (duration: 124.995388ms)"],"step_count":1}