{"level":"warn","ts":"2026-02-25T15:01:29.4857Z","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-25T15:01:29.485772Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-25T15:01:29.485828Z","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-25T15:01:29.485849Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-02-25T15:01:29.485863Z","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-25T15:01:29.486543Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-02-25T15:01:29.486662Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-25T15:01:29.491679Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.759201ms"} {"level":"info","ts":"2026-02-25T15:01:29.499145Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-02-25T15:01:29.499214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T15:01:29.499236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-02-25T15:01:29.499251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T15:01:29.499311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-02-25T15:01:29.49938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-02-25T15:01:29.507186Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T15:01:29.509036Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T15:01:29.510124Z","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-25T15:01:29.512794Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T15:01:29.512945Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T15:01:29.513111Z","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-25T15:01:29.513196Z","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-25T15:01:29.513217Z","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-25T15:01:29.514901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-02-25T15:01:29.516248Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-02-25T15:01:29.518611Z","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-25T15:01:29.518792Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-02-25T15:01:29.518892Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-02-25T15:01:29.518994Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T15:01:29.519074Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T15:01:30.100007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T15:01:30.10011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T15:01:30.100137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-02-25T15:01:30.100159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-02-25T15:01:30.10024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-02-25T15:01:30.100378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-02-25T15:01:30.10041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-02-25T15:01:30.103392Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:01:30.104522Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T15:01:30.104548Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T15:01:30.104601Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T15:01:30.105Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T15:01:30.10506Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T15:01:30.106188Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:01:30.106405Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:01:30.106456Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:01:30.107069Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T15:01:30.10821Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-02-25T15:01:53.757499Z","caller":"traceutil/trace.go:171","msg":"trace[51657595] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"164.531336ms","start":"2026-02-25T15:01:53.592951Z","end":"2026-02-25T15:01:53.757483Z","steps":["trace[51657595] 'process raft request' (duration: 164.424851ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:01:54.072529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.041924ms","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-25T15:01:54.072627Z","caller":"traceutil/trace.go:171","msg":"trace[1681485844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:459; }","duration":"157.18188ms","start":"2026-02-25T15:01:53.915425Z","end":"2026-02-25T15:01:54.072607Z","steps":["trace[1681485844] 'range keys from in-memory index tree' (duration: 156.949049ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:01:58.280242Z","caller":"traceutil/trace.go:171","msg":"trace[1074020313] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"181.578387ms","start":"2026-02-25T15:01:58.098645Z","end":"2026-02-25T15:01:58.280223Z","steps":["trace[1074020313] 'process raft request' (duration: 181.474422ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:01:58.703888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.94133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3866"} {"level":"info","ts":"2026-02-25T15:01:58.703979Z","caller":"traceutil/trace.go:171","msg":"trace[2135490240] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:503; }","duration":"238.074136ms","start":"2026-02-25T15:01:58.465882Z","end":"2026-02-25T15:01:58.703956Z","steps":["trace[2135490240] 'range keys from in-memory index tree' (duration: 237.760521ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:01:58.735106Z","caller":"traceutil/trace.go:171","msg":"trace[1695282858] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:517; }","duration":"103.002748ms","start":"2026-02-25T15:01:58.632072Z","end":"2026-02-25T15:01:58.735075Z","steps":["trace[1695282858] 'read index received' (duration: 77.085026ms)","trace[1695282858] 'applied index is now lower than readState.Index' (duration: 25.916202ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:01:58.735292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.201076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-25T15:01:58.735384Z","caller":"traceutil/trace.go:171","msg":"trace[1725529509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:503; }","duration":"103.340523ms","start":"2026-02-25T15:01:58.632023Z","end":"2026-02-25T15:01:58.735363Z","steps":["trace[1725529509] 'agreement among raft nodes before linearized reading' (duration: 103.139444ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:02:01.861298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.337985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:02:01.861416Z","caller":"traceutil/trace.go:171","msg":"trace[695799425] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:510; }","duration":"584.500161ms","start":"2026-02-25T15:02:01.27689Z","end":"2026-02-25T15:02:01.86139Z","steps":["trace[695799425] 'range keys from in-memory index tree' (duration: 584.20458ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:02:01.861469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:01.276874Z","time spent":"584.582285ms","remote":"127.0.0.1:59994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"info","ts":"2026-02-25T15:02:05.313362Z","caller":"traceutil/trace.go:171","msg":"trace[1165256192] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"156.660088ms","start":"2026-02-25T15:02:05.156672Z","end":"2026-02-25T15:02:05.313333Z","steps":["trace[1165256192] 'process raft request' (duration: 156.497211ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:02:05.36228Z","caller":"traceutil/trace.go:171","msg":"trace[653169493] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"117.609985ms","start":"2026-02-25T15:02:05.244629Z","end":"2026-02-25T15:02:05.362239Z","steps":["trace[653169493] 'process raft request' (duration: 117.46379ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:02:05.869Z","caller":"traceutil/trace.go:171","msg":"trace[424263849] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"114.014346ms","start":"2026-02-25T15:02:05.754967Z","end":"2026-02-25T15:02:05.868981Z","steps":["trace[424263849] 'process raft request' (duration: 113.885541ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:02:06.635866Z","caller":"traceutil/trace.go:171","msg":"trace[1709534811] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"324.788052ms","start":"2026-02-25T15:02:06.311042Z","end":"2026-02-25T15:02:06.63583Z","steps":["trace[1709534811] 'process raft request' (duration: 324.537263ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:02:06.637386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:06.311021Z","time spent":"325.695207ms","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:02:08.058699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.879841ms","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-25T15:02:08.058783Z","caller":"traceutil/trace.go:171","msg":"trace[1916611255] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:552; }","duration":"152.052468ms","start":"2026-02-25T15:02:07.90671Z","end":"2026-02-25T15:02:08.058763Z","steps":["trace[1916611255] 'range keys from in-memory index tree' (duration: 151.708205ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:02:09.076001Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116645059239850,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T15:02:09.092356Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.028730246s","expected-duration":"1s"} {"level":"info","ts":"2026-02-25T15:02:09.092875Z","caller":"traceutil/trace.go:171","msg":"trace[211092464] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"1.029315457s","start":"2026-02-25T15:02:08.063536Z","end":"2026-02-25T15:02:09.092851Z","steps":["trace[211092464] 'process raft request' (duration: 1.029157312s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:02:09.093025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:08.063508Z","time spent":"1.029426362s","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:02:09.215163Z","caller":"traceutil/trace.go:171","msg":"trace[1600531814] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:568; }","duration":"639.579893ms","start":"2026-02-25T15:02:08.575564Z","end":"2026-02-25T15:02:09.215144Z","steps":["trace[1600531814] 'read index received' (duration: 517.143188ms)","trace[1600531814] 'applied index is now lower than readState.Index' (duration: 122.435785ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:02:09.21532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.736049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T15:02:09.215413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.607551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T15:02:09.215422Z","caller":"traceutil/trace.go:171","msg":"trace[377250075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"639.894205ms","start":"2026-02-25T15:02:08.575507Z","end":"2026-02-25T15:02:09.215401Z","steps":["trace[377250075] 'agreement among raft nodes before linearized reading' (duration: 639.716218ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:02:09.215438Z","caller":"traceutil/trace.go:171","msg":"trace[6871189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:553; }","duration":"364.655723ms","start":"2026-02-25T15:02:08.850775Z","end":"2026-02-25T15:02:09.215431Z","steps":["trace[6871189] 'agreement among raft nodes before linearized reading' (duration: 364.608711ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:02:09.215465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:08.850761Z","time spent":"364.699935ms","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T15:02:09.215471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:08.575485Z","time spent":"639.976918ms","remote":"127.0.0.1:60158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T15:02:09.215654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.916793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-25T15:02:09.215701Z","caller":"traceutil/trace.go:171","msg":"trace[461044387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:553; }","duration":"383.961495ms","start":"2026-02-25T15:02:08.831706Z","end":"2026-02-25T15:02:09.215668Z","steps":["trace[461044387] 'agreement among raft nodes before linearized reading' (duration: 383.918973ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:02:09.215719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:08.831691Z","time spent":"384.024667ms","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T15:02:09.215363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.722751ms","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-25T15:02:09.215798Z","caller":"traceutil/trace.go:171","msg":"trace[1506742848] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:553; }","duration":"570.187409ms","start":"2026-02-25T15:02:08.645569Z","end":"2026-02-25T15:02:09.215756Z","steps":["trace[1506742848] 'agreement among raft nodes before linearized reading' (duration: 569.67387ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:02:09.215844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:08.645548Z","time spent":"570.284392ms","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-25T15:02:11.221374Z","caller":"traceutil/trace.go:171","msg":"trace[615718614] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"124.288449ms","start":"2026-02-25T15:02:11.097068Z","end":"2026-02-25T15:02:11.221356Z","steps":["trace[615718614] 'read index received' (duration: 124.180715ms)","trace[615718614] 'applied index is now lower than readState.Index' (duration: 106.784µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:02:11.221607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.535568ms","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-25T15:02:11.221634Z","caller":"traceutil/trace.go:171","msg":"trace[1705006506] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"124.616011ms","start":"2026-02-25T15:02:11.097008Z","end":"2026-02-25T15:02:11.221624Z","steps":["trace[1705006506] 'agreement among raft nodes before linearized reading' (duration: 124.423135ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:02:11.221635Z","caller":"traceutil/trace.go:171","msg":"trace[1093718336] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"168.777035ms","start":"2026-02-25T15:02:11.052827Z","end":"2026-02-25T15:02:11.221604Z","steps":["trace[1093718336] 'process raft request' (duration: 168.415382ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:39.868877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.691824ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T15:03:39.868975Z","caller":"traceutil/trace.go:171","msg":"trace[198433211] linearizableReadLoop","detail":"{readStateIndex:1042; appliedIndex:1041; }","duration":"599.178834ms","start":"2026-02-25T15:03:39.269784Z","end":"2026-02-25T15:03:39.868963Z","steps":["trace[198433211] 'read index received' (duration: 203.307423ms)","trace[198433211] 'applied index is now lower than readState.Index' (duration: 395.870371ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:39.869024Z","caller":"traceutil/trace.go:171","msg":"trace[1622124981] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"669.067953ms","start":"2026-02-25T15:03:39.199928Z","end":"2026-02-25T15:03:39.868995Z","steps":["trace[1622124981] 'process raft request' (duration: 273.293173ms)","trace[1622124981] 'compare' (duration: 380.294718ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:03:39.869132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.540434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T15:03:39.869154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:39.199904Z","time spent":"669.183625ms","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:39.869167Z","caller":"traceutil/trace.go:171","msg":"trace[1959849740] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1001; }","duration":"293.616204ms","start":"2026-02-25T15:03:39.575542Z","end":"2026-02-25T15:03:39.869158Z","steps":["trace[1959849740] 'agreement among raft nodes before linearized reading' (duration: 293.531623ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:39.869061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.284466ms","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-25T15:03:39.869244Z","caller":"traceutil/trace.go:171","msg":"trace[35414533] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1001; }","duration":"599.508269ms","start":"2026-02-25T15:03:39.269728Z","end":"2026-02-25T15:03:39.869236Z","steps":["trace[35414533] 'agreement among raft nodes before linearized reading' (duration: 599.297896ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:39.869266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:39.269704Z","time spent":"599.55405ms","remote":"127.0.0.1:60392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-02-25T15:03:39.869361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.662555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T15:03:39.86938Z","caller":"traceutil/trace.go:171","msg":"trace[1449306493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1001; }","duration":"147.702547ms","start":"2026-02-25T15:03:39.721673Z","end":"2026-02-25T15:03:39.869375Z","steps":["trace[1449306493] 'agreement among raft nodes before linearized reading' (duration: 147.629425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:39.869457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.655738ms","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-25T15:03:39.869471Z","caller":"traceutil/trace.go:171","msg":"trace[1882653143] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1001; }","duration":"168.705559ms","start":"2026-02-25T15:03:39.700761Z","end":"2026-02-25T15:03:39.869466Z","steps":["trace[1882653143] 'agreement among raft nodes before linearized reading' (duration: 168.663238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:40.996492Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.123871863s","expected-duration":"1s"} {"level":"info","ts":"2026-02-25T15:03:41.050803Z","caller":"traceutil/trace.go:171","msg":"trace[706442134] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"1.178236528s","start":"2026-02-25T15:03:39.872543Z","end":"2026-02-25T15:03:41.05078Z","steps":["trace[706442134] 'process raft request' (duration: 1.12430719s)","trace[706442134] 'compare' (duration: 53.661614ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:03:41.050959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:39.872527Z","time spent":"1.17835631s","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:41.082823Z","caller":"traceutil/trace.go:171","msg":"trace[852063433] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"1.207924035s","start":"2026-02-25T15:03:39.874875Z","end":"2026-02-25T15:03:41.082799Z","steps":["trace[852063433] 'process raft request' (duration: 1.207855414s)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:41.082865Z","caller":"traceutil/trace.go:171","msg":"trace[1777244591] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"1.209590181s","start":"2026-02-25T15:03:39.873237Z","end":"2026-02-25T15:03:41.082827Z","steps":["trace[1777244591] 'process raft request' (duration: 1.209353648s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:41.083006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:39.873224Z","time spent":"1.209709533s","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:03:41.082993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:39.874852Z","time spent":"1.208046426s","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:41.083016Z","caller":"traceutil/trace.go:171","msg":"trace[805444051] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1042; }","duration":"452.776053ms","start":"2026-02-25T15:03:40.630214Z","end":"2026-02-25T15:03:41.082991Z","steps":["trace[805444051] 'read index received' (duration: 366.629477ms)","trace[805444051] 'applied index is now lower than readState.Index' (duration: 86.143846ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:03:41.083167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.252436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T15:03:41.083186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.957847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:03:41.083205Z","caller":"traceutil/trace.go:171","msg":"trace[1062561787] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1005; }","duration":"394.332627ms","start":"2026-02-25T15:03:40.688862Z","end":"2026-02-25T15:03:41.083195Z","steps":["trace[1062561787] 'agreement among raft nodes before linearized reading' (duration: 394.267766ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:41.083214Z","caller":"traceutil/trace.go:171","msg":"trace[1157397521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1005; }","duration":"453.058118ms","start":"2026-02-25T15:03:40.630146Z","end":"2026-02-25T15:03:41.083205Z","steps":["trace[1157397521] 'agreement among raft nodes before linearized reading' (duration: 452.955957ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:41.083184Z","caller":"traceutil/trace.go:171","msg":"trace[382763360] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"1.208082158s","start":"2026-02-25T15:03:39.875062Z","end":"2026-02-25T15:03:41.083145Z","steps":["trace[382763360] 'process raft request' (duration: 1.207703681s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:41.083247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:40.630099Z","time spent":"453.14027ms","remote":"127.0.0.1:60158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T15:03:41.083279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.134495ms","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":"warn","ts":"2026-02-25T15:03:41.083232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:40.688838Z","time spent":"394.388598ms","remote":"127.0.0.1:60046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"info","ts":"2026-02-25T15:03:41.083303Z","caller":"traceutil/trace.go:171","msg":"trace[360063162] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1005; }","duration":"165.195227ms","start":"2026-02-25T15:03:40.918101Z","end":"2026-02-25T15:03:41.083296Z","steps":["trace[360063162] 'agreement among raft nodes before linearized reading' (duration: 165.145936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:41.083375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:39.875049Z","time spent":"1.208234271s","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:03:43.002846Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.125236528s","expected-duration":"1s"} {"level":"info","ts":"2026-02-25T15:03:43.003321Z","caller":"traceutil/trace.go:171","msg":"trace[2124988376] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1046; }","duration":"460.707067ms","start":"2026-02-25T15:03:42.54259Z","end":"2026-02-25T15:03:43.003297Z","steps":["trace[2124988376] 'read index received' (duration: 460.440383ms)","trace[2124988376] 'applied index is now lower than readState.Index' (duration: 265.444µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:43.003424Z","caller":"traceutil/trace.go:171","msg":"trace[55372239] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"1.125902529s","start":"2026-02-25T15:03:41.87747Z","end":"2026-02-25T15:03:43.003372Z","steps":["trace[55372239] 'process raft request' (duration: 1.125659845s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:43.003459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.851939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:03:43.003496Z","caller":"traceutil/trace.go:171","msg":"trace[1523791856] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1006; }","duration":"460.94917ms","start":"2026-02-25T15:03:42.542536Z","end":"2026-02-25T15:03:43.003485Z","steps":["trace[1523791856] 'agreement among raft nodes before linearized reading' (duration: 460.867559ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:43.003538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:42.542484Z","time spent":"461.044263ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-02-25T15:03:43.003598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.185947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T15:03:43.003656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:41.877444Z","time spent":"1.126076181s","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:03:43.003709Z","caller":"traceutil/trace.go:171","msg":"trace[1969544566] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1006; }","duration":"428.325029ms","start":"2026-02-25T15:03:42.575349Z","end":"2026-02-25T15:03:43.003674Z","steps":["trace[1969544566] 'agreement among raft nodes before linearized reading' (duration: 428.146236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:43.003797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:03:42.575337Z","time spent":"428.426341ms","remote":"127.0.0.1:60158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T15:03:43.201763Z","caller":"traceutil/trace.go:171","msg":"trace[440945898] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"110.845192ms","start":"2026-02-25T15:03:43.090896Z","end":"2026-02-25T15:03:43.201741Z","steps":["trace[440945898] 'process raft request' (duration: 110.754461ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:43.201778Z","caller":"traceutil/trace.go:171","msg":"trace[325985315] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"138.650104ms","start":"2026-02-25T15:03:43.063109Z","end":"2026-02-25T15:03:43.201759Z","steps":["trace[325985315] 'process raft request' (duration: 102.292876ms)","trace[325985315] 'compare' (duration: 35.84663ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:03:43.201959Z","caller":"traceutil/trace.go:171","msg":"trace[1053486328] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1047; }","duration":"114.198314ms","start":"2026-02-25T15:03:43.087751Z","end":"2026-02-25T15:03:43.201949Z","steps":["trace[1053486328] 'read index received' (duration: 2.161584ms)","trace[1053486328] 'applied index is now lower than readState.Index' (duration: 111.907778ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:03:43.202177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.422289ms","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-25T15:03:43.202244Z","caller":"traceutil/trace.go:171","msg":"trace[1105746259] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1008; }","duration":"114.53186ms","start":"2026-02-25T15:03:43.087703Z","end":"2026-02-25T15:03:43.202235Z","steps":["trace[1105746259] 'agreement among raft nodes before linearized reading' (duration: 114.349287ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:43.202258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.654506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-25T15:03:43.202405Z","caller":"traceutil/trace.go:171","msg":"trace[440435509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1008; }","duration":"113.827179ms","start":"2026-02-25T15:03:43.08857Z","end":"2026-02-25T15:03:43.202397Z","steps":["trace[440435509] 'agreement among raft nodes before linearized reading' (duration: 113.637986ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:43.202413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.528574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T15:03:43.202495Z","caller":"traceutil/trace.go:171","msg":"trace[531498725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1008; }","duration":"113.625615ms","start":"2026-02-25T15:03:43.088861Z","end":"2026-02-25T15:03:43.202487Z","steps":["trace[531498725] 'agreement among raft nodes before linearized reading' (duration: 113.506953ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:43.38594Z","caller":"traceutil/trace.go:171","msg":"trace[1934142382] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"179.054065ms","start":"2026-02-25T15:03:43.206863Z","end":"2026-02-25T15:03:43.385917Z","steps":["trace[1934142382] 'process raft request' (duration: 176.523545ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:43.402944Z","caller":"traceutil/trace.go:171","msg":"trace[345460916] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"195.938974ms","start":"2026-02-25T15:03:43.206984Z","end":"2026-02-25T15:03:43.402923Z","steps":["trace[345460916] 'process raft request' (duration: 195.722141ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:43.402994Z","caller":"traceutil/trace.go:171","msg":"trace[540094748] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"195.70093ms","start":"2026-02-25T15:03:43.207264Z","end":"2026-02-25T15:03:43.402965Z","steps":["trace[540094748] 'process raft request' (duration: 195.614078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:03:43.403303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.582618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-02-25T15:03:43.403412Z","caller":"traceutil/trace.go:171","msg":"trace[704113098] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1011; }","duration":"195.777431ms","start":"2026-02-25T15:03:43.20762Z","end":"2026-02-25T15:03:43.403398Z","steps":["trace[704113098] 'agreement among raft nodes before linearized reading' (duration: 195.579618ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:03:43.40301Z","caller":"traceutil/trace.go:171","msg":"trace[1996284792] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1050; }","duration":"195.279383ms","start":"2026-02-25T15:03:43.207661Z","end":"2026-02-25T15:03:43.40294Z","steps":["trace[1996284792] 'read index received' (duration: 175.794134ms)","trace[1996284792] 'applied index is now lower than readState.Index' (duration: 19.483949ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:04:03.831081Z","caller":"traceutil/trace.go:171","msg":"trace[1139883240] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1117; }","duration":"101.763037ms","start":"2026-02-25T15:04:03.729293Z","end":"2026-02-25T15:04:03.831056Z","steps":["trace[1139883240] 'read index received' (duration: 52.77597ms)","trace[1139883240] 'applied index is now lower than readState.Index' (duration: 48.986017ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:04:03.831265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.946079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubeadm-certs\" ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-02-25T15:04:03.831242Z","caller":"traceutil/trace.go:171","msg":"trace[1800557372] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"102.917023ms","start":"2026-02-25T15:04:03.72829Z","end":"2026-02-25T15:04:03.831207Z","steps":["trace[1800557372] 'process raft request' (duration: 53.863805ms)","trace[1800557372] 'compare' (duration: 48.787394ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:04:03.831465Z","caller":"traceutil/trace.go:171","msg":"trace[604902398] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:1071; }","duration":"102.183872ms","start":"2026-02-25T15:04:03.729269Z","end":"2026-02-25T15:04:03.831453Z","steps":["trace[604902398] 'agreement among raft nodes before linearized reading' (duration: 101.930129ms)"],"step_count":1}