{"level":"warn","ts":"2026-05-19T00:06:44.656819Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T00:06:44.656982Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144: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.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-05-19T00:06:44.657143Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T00:06:44.657188Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-05-19T00:06:44.657242Z","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-05-19T00:06:44.657979Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-05-19T00:06:44.658164Z","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.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-05-19T00:06:44.672498Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"14.063791ms"} {"level":"info","ts":"2026-05-19T00:06:44.688973Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-05-19T00:06:44.689077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T00:06:44.68911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-05-19T00:06:44.689129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T00:06:44.689151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-05-19T00:06:44.689219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-05-19T00:06:44.696501Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T00:06:44.697999Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T00:06:44.711965Z","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-05-19T00:06:44.714989Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T00:06:44.715252Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T00:06:44.71546Z","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-05-19T00:06:44.715579Z","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-05-19T00:06:44.7156Z","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-05-19T00:06:44.719507Z","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-05-19T00:06:44.71961Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-05-19T00:06:44.719635Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-05-19T00:06:44.719982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-05-19T00:06:44.720141Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-05-19T00:06:44.721507Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T00:06:44.721559Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T00:06:45.689918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T00:06:45.689978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T00:06:45.690003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-05-19T00:06:45.690018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-05-19T00:06:45.690033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-05-19T00:06:45.690046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-05-19T00:06:45.690064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-05-19T00:06:45.690926Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T00:06:45.691774Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T00:06:45.691838Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T00:06:45.691813Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T00:06:45.69199Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T00:06:45.692155Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T00:06:45.692408Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T00:06:45.692605Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T00:06:45.692645Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T00:06:45.694491Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-05-19T00:06:45.694521Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T00:06:47.143847Z","caller":"traceutil/trace.go:171","msg":"trace[1173965120] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"166.939727ms","start":"2026-05-19T00:06:46.976879Z","end":"2026-05-19T00:06:47.143819Z","steps":["trace[1173965120] 'process raft request' (duration: 166.694852ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:48.028945Z","caller":"traceutil/trace.go:171","msg":"trace[1268174557] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"1.049360301s","start":"2026-05-19T00:06:46.979563Z","end":"2026-05-19T00:06:48.028923Z","steps":["trace[1268174557] 'read index received' (duration: 164.074604ms)","trace[1268174557] 'applied index is now lower than readState.Index' (duration: 885.284667ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:06:48.029057Z","caller":"traceutil/trace.go:171","msg":"trace[579293881] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.051872717s","start":"2026-05-19T00:06:46.977175Z","end":"2026-05-19T00:06:48.029048Z","steps":["trace[579293881] 'process raft request' (duration: 1.051308974s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.029579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:46.977144Z","time spent":"1.051941498s","remote":"127.0.0.1:60640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:06:48.029648Z","caller":"traceutil/trace.go:171","msg":"trace[2061052101] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"970.07019ms","start":"2026-05-19T00:06:47.059546Z","end":"2026-05-19T00:06:48.029616Z","steps":["trace[2061052101] 'process raft request' (duration: 969.317983ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:48.029667Z","caller":"traceutil/trace.go:171","msg":"trace[16927297] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"982.266999ms","start":"2026-05-19T00:06:47.047368Z","end":"2026-05-19T00:06:48.029635Z","steps":["trace[16927297] 'process raft request' (duration: 981.240356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.029768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.059536Z","time spent":"970.174052ms","remote":"127.0.0.1:60740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T00:06:48.029798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.047345Z","time spent":"982.386372ms","remote":"127.0.0.1:32806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:06:48.029885Z","caller":"traceutil/trace.go:171","msg":"trace[1199645825] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"978.626168ms","start":"2026-05-19T00:06:47.051243Z","end":"2026-05-19T00:06:48.029869Z","steps":["trace[1199645825] 'process raft request' (duration: 977.586495ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.029918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.051218Z","time spent":"978.68421ms","remote":"127.0.0.1:60978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:06:48.029916Z","caller":"traceutil/trace.go:171","msg":"trace[1816583050] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"962.493463ms","start":"2026-05-19T00:06:47.067409Z","end":"2026-05-19T00:06:48.029903Z","steps":["trace[1816583050] 'process raft request' (duration: 961.485251ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.029982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.067384Z","time spent":"962.563774ms","remote":"127.0.0.1:60818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:06:48.030004Z","caller":"traceutil/trace.go:171","msg":"trace[57167471] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"982.095616ms","start":"2026-05-19T00:06:47.047896Z","end":"2026-05-19T00:06:48.029991Z","steps":["trace[57167471] 'process raft request' (duration: 980.815428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.030053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.047883Z","time spent":"982.147157ms","remote":"127.0.0.1:32806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:06:48.030182Z","caller":"traceutil/trace.go:171","msg":"trace[678978714] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"981.848ms","start":"2026-05-19T00:06:47.048317Z","end":"2026-05-19T00:06:48.030165Z","steps":["trace[678978714] 'process raft request' (duration: 980.432619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.030244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.047952Z","time spent":"982.253219ms","remote":"127.0.0.1:32806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:06:48.030357Z","caller":"traceutil/trace.go:171","msg":"trace[1671460856] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"981.833799ms","start":"2026-05-19T00:06:47.04851Z","end":"2026-05-19T00:06:48.030344Z","steps":["trace[1671460856] 'process raft request' (duration: 980.267415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.030437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.048488Z","time spent":"981.89977ms","remote":"127.0.0.1:32806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:06:48.03057Z","caller":"traceutil/trace.go:171","msg":"trace[1713875977] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"982.012973ms","start":"2026-05-19T00:06:47.048547Z","end":"2026-05-19T00:06:48.03056Z","steps":["trace[1713875977] 'process raft request' (duration: 980.255555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.030621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.048531Z","time spent":"982.071834ms","remote":"127.0.0.1:32806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T00:06:48.032256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.050717161s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T00:06:48.032309Z","caller":"traceutil/trace.go:171","msg":"trace[436415754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"1.052749746s","start":"2026-05-19T00:06:46.979539Z","end":"2026-05-19T00:06:48.032289Z","steps":["trace[436415754] 'agreement among raft nodes before linearized reading' (duration: 1.050572207s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.032333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:46.979533Z","time spent":"1.052793787s","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T00:06:48.032485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"935.68716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T00:06:48.032512Z","caller":"traceutil/trace.go:171","msg":"trace[689886768] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"935.716691ms","start":"2026-05-19T00:06:47.09679Z","end":"2026-05-19T00:06:48.032506Z","steps":["trace[689886768] 'agreement among raft nodes before linearized reading' (duration: 935.678301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.032531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.096774Z","time spent":"935.753252ms","remote":"127.0.0.1:60678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-19T00:06:48.032678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.085182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T00:06:48.032705Z","caller":"traceutil/trace.go:171","msg":"trace[2106420624] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:0; response_revision:11; }","duration":"990.133793ms","start":"2026-05-19T00:06:47.042565Z","end":"2026-05-19T00:06:48.032699Z","steps":["trace[2106420624] 'agreement among raft nodes before linearized reading' (duration: 990.092202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.032724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.042552Z","time spent":"990.167924ms","remote":"127.0.0.1:60598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.144\" "} {"level":"warn","ts":"2026-05-19T00:06:48.032823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.884801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T00:06:48.032848Z","caller":"traceutil/trace.go:171","msg":"trace[574735976] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"986.969333ms","start":"2026-05-19T00:06:47.045873Z","end":"2026-05-19T00:06:48.032842Z","steps":["trace[574735976] 'agreement among raft nodes before linearized reading' (duration: 986.937362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.032868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.045851Z","time spent":"987.013243ms","remote":"127.0.0.1:60678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-19T00:06:48.033304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.016056006s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T00:06:48.033331Z","caller":"traceutil/trace.go:171","msg":"trace[1594498021] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.016084006s","start":"2026-05-19T00:06:47.017241Z","end":"2026-05-19T00:06:48.033325Z","steps":["trace[1594498021] 'agreement among raft nodes before linearized reading' (duration: 1.016042235s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.033353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.017161Z","time spent":"1.016183919s","remote":"127.0.0.1:60678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-19T00:06:48.03355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.045613628s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T00:06:48.033576Z","caller":"traceutil/trace.go:171","msg":"trace[1289491927] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"1.04569611s","start":"2026-05-19T00:06:46.987874Z","end":"2026-05-19T00:06:48.03357Z","steps":["trace[1289491927] 'agreement among raft nodes before linearized reading' (duration: 1.045646658s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.033594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:46.987863Z","time spent":"1.045727471s","remote":"127.0.0.1:60930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-19T00:06:48.036283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05071299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T00:06:48.036429Z","caller":"traceutil/trace.go:171","msg":"trace[1916968264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"1.056784235s","start":"2026-05-19T00:06:46.979617Z","end":"2026-05-19T00:06:48.036402Z","steps":["trace[1916968264] 'agreement among raft nodes before linearized reading' (duration: 1.050685481s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.036508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:46.979607Z","time spent":"1.056888617s","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T00:06:48.037123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.120028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-19T00:06:48.03714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.166124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T00:06:48.037191Z","caller":"traceutil/trace.go:171","msg":"trace[1449462857] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"928.194326ms","start":"2026-05-19T00:06:47.10898Z","end":"2026-05-19T00:06:48.037174Z","steps":["trace[1449462857] 'agreement among raft nodes before linearized reading' (duration: 923.189755ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.037223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.108956Z","time spent":"928.260157ms","remote":"127.0.0.1:60678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"info","ts":"2026-05-19T00:06:48.037186Z","caller":"traceutil/trace.go:171","msg":"trace[2025482895] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"989.123492ms","start":"2026-05-19T00:06:47.048045Z","end":"2026-05-19T00:06:48.037169Z","steps":["trace[2025482895] 'agreement among raft nodes before linearized reading' (duration: 983.090168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.03821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:47.047922Z","time spent":"989.435168ms","remote":"127.0.0.1:60652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-05-19T00:07:15.596392Z","caller":"traceutil/trace.go:171","msg":"trace[1645478057] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"235.316551ms","start":"2026-05-19T00:07:15.361039Z","end":"2026-05-19T00:07:15.596356Z","steps":["trace[1645478057] 'process raft request' (duration: 235.136626ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:16.293332Z","caller":"traceutil/trace.go:171","msg":"trace[1860403015] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"399.051891ms","start":"2026-05-19T00:07:15.894255Z","end":"2026-05-19T00:07:16.293307Z","steps":["trace[1860403015] 'process raft request' (duration: 398.885857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:16.293483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.894238Z","time spent":"399.179975ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:07:16.301485Z","caller":"traceutil/trace.go:171","msg":"trace[1062103352] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:531; }","duration":"138.18655ms","start":"2026-05-19T00:07:16.163283Z","end":"2026-05-19T00:07:16.301469Z","steps":["trace[1062103352] 'read index received' (duration: 129.918762ms)","trace[1062103352] 'applied index is now lower than readState.Index' (duration: 8.267007ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:07:16.301634Z","caller":"traceutil/trace.go:171","msg":"trace[281057919] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"403.931529ms","start":"2026-05-19T00:07:15.897692Z","end":"2026-05-19T00:07:16.301623Z","steps":["trace[281057919] 'process raft request' (duration: 403.284473ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:16.301712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.89766Z","time spent":"404.003592ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:07:16.301817Z","caller":"traceutil/trace.go:171","msg":"trace[2134578592] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"374.729723ms","start":"2026-05-19T00:07:15.927077Z","end":"2026-05-19T00:07:16.301806Z","steps":["trace[2134578592] 'process raft request' (duration: 374.171409ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:16.301852Z","caller":"traceutil/trace.go:171","msg":"trace[1671125049] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"402.465152ms","start":"2026-05-19T00:07:15.899376Z","end":"2026-05-19T00:07:16.301841Z","steps":["trace[1671125049] 'process raft request' (duration: 401.670562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:16.301864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.92705Z","time spent":"374.792734ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T00:07:16.30198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.899353Z","time spent":"402.521273ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:07:16.302012Z","caller":"traceutil/trace.go:171","msg":"trace[157737304] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"319.272506ms","start":"2026-05-19T00:07:15.982731Z","end":"2026-05-19T00:07:16.302004Z","steps":["trace[157737304] 'process raft request' (duration: 318.64172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:16.302057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.982705Z","time spent":"319.329157ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:07:16.302071Z","caller":"traceutil/trace.go:171","msg":"trace[1976464351] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"396.921926ms","start":"2026-05-19T00:07:15.905142Z","end":"2026-05-19T00:07:16.302064Z","steps":["trace[1976464351] 'process raft request' (duration: 395.947531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:16.302104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.905125Z","time spent":"396.964428ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:07:16.30213Z","caller":"traceutil/trace.go:171","msg":"trace[92640196] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"200.098445ms","start":"2026-05-19T00:07:16.102022Z","end":"2026-05-19T00:07:16.302121Z","steps":["trace[92640196] 'process raft request' (duration: 199.408118ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:16.302162Z","caller":"traceutil/trace.go:171","msg":"trace[1896653997] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"385.737881ms","start":"2026-05-19T00:07:15.916417Z","end":"2026-05-19T00:07:16.302155Z","steps":["trace[1896653997] 'process raft request' (duration: 384.701974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:16.302189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.91641Z","time spent":"385.765822ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T00:07:16.302246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.955439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:07:16.30228Z","caller":"traceutil/trace.go:171","msg":"trace[1538443436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:527; }","duration":"139.017461ms","start":"2026-05-19T00:07:16.163252Z","end":"2026-05-19T00:07:16.302269Z","steps":["trace[1538443436] 'agreement among raft nodes before linearized reading' (duration: 138.940419ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:16.301798Z","caller":"traceutil/trace.go:171","msg":"trace[65652397] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"385.199667ms","start":"2026-05-19T00:07:15.916578Z","end":"2026-05-19T00:07:16.301778Z","steps":["trace[65652397] 'process raft request' (duration: 384.635583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:16.302366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.916575Z","time spent":"385.761582ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:07:16.30255Z","caller":"traceutil/trace.go:171","msg":"trace[183751847] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"386.08488ms","start":"2026-05-19T00:07:15.916459Z","end":"2026-05-19T00:07:16.302543Z","steps":["trace[183751847] 'process raft request' (duration: 384.688994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:16.302587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.916455Z","time spent":"386.113851ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:07:16.302694Z","caller":"traceutil/trace.go:171","msg":"trace[1968103984] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"386.153912ms","start":"2026-05-19T00:07:15.916535Z","end":"2026-05-19T00:07:16.302688Z","steps":["trace[1968103984] 'process raft request' (duration: 384.639213ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:16.302721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.91653Z","time spent":"386.177763ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:07:16.301982Z","caller":"traceutil/trace.go:171","msg":"trace[2038260957] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"365.707825ms","start":"2026-05-19T00:07:15.936263Z","end":"2026-05-19T00:07:16.301971Z","steps":["trace[2038260957] 'process raft request' (duration: 365.055299ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:16.302794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:15.936247Z","time spent":"366.519406ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:07:21.865961Z","caller":"traceutil/trace.go:171","msg":"trace[1043100467] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"130.640821ms","start":"2026-05-19T00:07:21.735294Z","end":"2026-05-19T00:07:21.865934Z","steps":["trace[1043100467] 'process raft request' (duration: 130.422326ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:22.345403Z","caller":"traceutil/trace.go:171","msg":"trace[322676029] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"182.298859ms","start":"2026-05-19T00:07:22.163035Z","end":"2026-05-19T00:07:22.345334Z","steps":["trace[322676029] 'read index received' (duration: 181.545959ms)","trace[322676029] 'applied index is now lower than readState.Index' (duration: 751.67µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:07:22.34548Z","caller":"traceutil/trace.go:171","msg":"trace[1673299572] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"311.144432ms","start":"2026-05-19T00:07:22.034259Z","end":"2026-05-19T00:07:22.345403Z","steps":["trace[1673299572] 'process raft request' (duration: 310.512986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:22.345741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:22.034229Z","time spent":"311.39424ms","remote":"127.0.0.1:60660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:07:22.346044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.994537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:07:22.34624Z","caller":"traceutil/trace.go:171","msg":"trace[939422498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"183.193602ms","start":"2026-05-19T00:07:22.163016Z","end":"2026-05-19T00:07:22.346209Z","steps":["trace[939422498] 'agreement among raft nodes before linearized reading' (duration: 182.934606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:23.149849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.478337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:07:23.1501Z","caller":"traceutil/trace.go:171","msg":"trace[429884373] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"744.035413ms","start":"2026-05-19T00:07:22.406047Z","end":"2026-05-19T00:07:23.150083Z","steps":["trace[429884373] 'process raft request' (duration: 743.967992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:23.150215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:22.40602Z","time spent":"744.163377ms","remote":"127.0.0.1:32792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:07:23.150433Z","caller":"traceutil/trace.go:171","msg":"trace[933267451] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"793.125743ms","start":"2026-05-19T00:07:22.357293Z","end":"2026-05-19T00:07:23.150419Z","steps":["trace[933267451] 'process raft request' (duration: 85.226928ms)","trace[933267451] 'compare' (duration: 706.350814ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:07:23.150528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:22.357274Z","time spent":"793.218425ms","remote":"127.0.0.1:60830","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-05-19T00:07:23.150765Z","caller":"traceutil/trace.go:171","msg":"trace[415191941] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"790.225187ms","start":"2026-05-19T00:07:22.360528Z","end":"2026-05-19T00:07:23.150753Z","steps":["trace[415191941] 'read index received' (duration: 81.995624ms)","trace[415191941] 'applied index is now lower than readState.Index' (duration: 708.227683ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:07:23.151016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.480893ms","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-05-19T00:07:23.151083Z","caller":"traceutil/trace.go:171","msg":"trace[613146888] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"790.571985ms","start":"2026-05-19T00:07:22.3605Z","end":"2026-05-19T00:07:23.151072Z","steps":["trace[613146888] 'agreement among raft nodes before linearized reading' (duration: 790.321669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:23.151147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:22.360487Z","time spent":"790.646288ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T00:07:39.257391Z","caller":"traceutil/trace.go:171","msg":"trace[1746924594] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"287.830209ms","start":"2026-05-19T00:07:38.96954Z","end":"2026-05-19T00:07:39.25737Z","steps":["trace[1746924594] 'process raft request' (duration: 285.838038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:39.690885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.600095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:07:39.691068Z","caller":"traceutil/trace.go:171","msg":"trace[1374646764] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"427.741755ms","start":"2026-05-19T00:07:39.263309Z","end":"2026-05-19T00:07:39.691051Z","steps":["trace[1374646764] 'process raft request' (duration: 427.678963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:39.691222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:39.263297Z","time spent":"427.805026ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:07:39.691163Z","caller":"traceutil/trace.go:171","msg":"trace[1175643849] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"428.251269ms","start":"2026-05-19T00:07:39.262882Z","end":"2026-05-19T00:07:39.691134Z","steps":["trace[1175643849] 'process raft request' (duration: 322.289705ms)","trace[1175643849] 'compare' (duration: 105.394779ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:07:39.691732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:39.262842Z","time spent":"428.809634ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:07:56.682802Z","caller":"traceutil/trace.go:171","msg":"trace[1631772397] linearizableReadLoop","detail":"{readStateIndex:977; appliedIndex:976; }","duration":"140.153969ms","start":"2026-05-19T00:07:56.54262Z","end":"2026-05-19T00:07:56.682773Z","steps":["trace[1631772397] 'read index received' (duration: 139.853552ms)","trace[1631772397] 'applied index is now lower than readState.Index' (duration: 299.077µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:07:56.683984Z","caller":"traceutil/trace.go:171","msg":"trace[1144794019] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"153.667055ms","start":"2026-05-19T00:07:56.530293Z","end":"2026-05-19T00:07:56.683961Z","steps":["trace[1144794019] 'process raft request' (duration: 152.317424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:56.68406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.377147ms","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-05-19T00:07:56.684134Z","caller":"traceutil/trace.go:171","msg":"trace[691246928] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:943; }","duration":"141.549861ms","start":"2026-05-19T00:07:56.542566Z","end":"2026-05-19T00:07:56.684116Z","steps":["trace[691246928] 'agreement among raft nodes before linearized reading' (duration: 140.986988ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:07.296668Z","caller":"traceutil/trace.go:171","msg":"trace[1452389107] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1012; }","duration":"123.552027ms","start":"2026-05-19T00:08:07.173089Z","end":"2026-05-19T00:08:07.296641Z","steps":["trace[1452389107] 'read index received' (duration: 123.371392ms)","trace[1452389107] 'applied index is now lower than readState.Index' (duration: 179.625µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:08:07.296831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.728251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:07.296869Z","caller":"traceutil/trace.go:171","msg":"trace[1412375869] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"123.808533ms","start":"2026-05-19T00:08:07.17305Z","end":"2026-05-19T00:08:07.296858Z","steps":["trace[1412375869] 'agreement among raft nodes before linearized reading' (duration: 123.68693ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:07.297409Z","caller":"traceutil/trace.go:171","msg":"trace[1011911550] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"253.026798ms","start":"2026-05-19T00:08:07.043821Z","end":"2026-05-19T00:08:07.296848Z","steps":["trace[1011911550] 'process raft request' (duration: 252.638358ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:13.753099Z","caller":"traceutil/trace.go:171","msg":"trace[852360314] linearizableReadLoop","detail":"{readStateIndex:1039; appliedIndex:1038; }","duration":"146.951677ms","start":"2026-05-19T00:08:13.606125Z","end":"2026-05-19T00:08:13.753077Z","steps":["trace[852360314] 'read index received' (duration: 146.712201ms)","trace[852360314] 'applied index is now lower than readState.Index' (duration: 238.386µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:08:13.753282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.137781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T00:08:13.753334Z","caller":"traceutil/trace.go:171","msg":"trace[1534696748] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1002; }","duration":"147.249433ms","start":"2026-05-19T00:08:13.606071Z","end":"2026-05-19T00:08:13.75332Z","steps":["trace[1534696748] 'agreement among raft nodes before linearized reading' (duration: 147.13015ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:13.75321Z","caller":"traceutil/trace.go:171","msg":"trace[97919293] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"436.458491ms","start":"2026-05-19T00:08:13.316717Z","end":"2026-05-19T00:08:13.753175Z","steps":["trace[97919293] 'process raft request' (duration: 436.220096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:13.753757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:13.316698Z","time spent":"436.984444ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:08:14.337942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.961166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-19T00:08:14.337958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.880598ms","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-05-19T00:08:14.338017Z","caller":"traceutil/trace.go:171","msg":"trace[1057179024] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1002; }","duration":"475.98371ms","start":"2026-05-19T00:08:13.862017Z","end":"2026-05-19T00:08:14.338001Z","steps":["trace[1057179024] 'range keys from in-memory index tree' (duration: 475.652442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:14.33804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:13.861982Z","time spent":"476.053312ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T00:08:14.33808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.767882ms","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-05-19T00:08:14.338109Z","caller":"traceutil/trace.go:171","msg":"trace[1578692859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1002; }","duration":"474.825643ms","start":"2026-05-19T00:08:13.863275Z","end":"2026-05-19T00:08:14.338101Z","steps":["trace[1578692859] 'range keys from in-memory index tree' (duration: 474.654209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:14.338142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:13.863264Z","time spent":"474.872694ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T00:08:14.338122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.123234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:14.338212Z","caller":"traceutil/trace.go:171","msg":"trace[1723133095] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1002; }","duration":"174.204206ms","start":"2026-05-19T00:08:14.163971Z","end":"2026-05-19T00:08:14.338176Z","steps":["trace[1723133095] 'range keys from in-memory index tree' (duration: 174.050633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:14.338451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.402319ms","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-05-19T00:08:14.338507Z","caller":"traceutil/trace.go:171","msg":"trace[1513951672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1002; }","duration":"476.479721ms","start":"2026-05-19T00:08:13.862002Z","end":"2026-05-19T00:08:14.338482Z","steps":["trace[1513951672] 'range keys from in-memory index tree' (duration: 475.52547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:14.338534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:13.861975Z","time spent":"476.554183ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T00:08:14.338007Z","caller":"traceutil/trace.go:171","msg":"trace[843449294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1002; }","duration":"316.062019ms","start":"2026-05-19T00:08:14.021924Z","end":"2026-05-19T00:08:14.337986Z","steps":["trace[843449294] 'range keys from in-memory index tree' (duration: 315.823633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:14.338761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:14.021906Z","time spent":"316.842966ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-19T00:08:16.452636Z","caller":"traceutil/trace.go:171","msg":"trace[121565341] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"100.075403ms","start":"2026-05-19T00:08:16.352542Z","end":"2026-05-19T00:08:16.452617Z","steps":["trace[121565341] 'process raft request' (duration: 99.94587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:32.841396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.665533ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:08:32.841516Z","caller":"traceutil/trace.go:171","msg":"trace[2044259754] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"212.035555ms","start":"2026-05-19T00:08:32.62946Z","end":"2026-05-19T00:08:32.841496Z","steps":["trace[2044259754] 'process raft request' (duration: 42.159337ms)","trace[2044259754] 'compare' (duration: 169.5327ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:33.989833Z","caller":"traceutil/trace.go:171","msg":"trace[1694000541] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"146.067627ms","start":"2026-05-19T00:08:33.843738Z","end":"2026-05-19T00:08:33.989806Z","steps":["trace[1694000541] 'process raft request' (duration: 145.924344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:36.554095Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440202359706016269,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T00:08:36.568632Z","caller":"traceutil/trace.go:171","msg":"trace[1298629373] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1115; }","duration":"514.70583ms","start":"2026-05-19T00:08:36.053902Z","end":"2026-05-19T00:08:36.568608Z","steps":["trace[1298629373] 'read index received' (duration: 514.401143ms)","trace[1298629373] 'applied index is now lower than readState.Index' (duration: 303.567µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:36.568708Z","caller":"traceutil/trace.go:171","msg":"trace[1907574517] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"573.907665ms","start":"2026-05-19T00:08:35.994763Z","end":"2026-05-19T00:08:36.568671Z","steps":["trace[1907574517] 'process raft request' (duration: 573.654609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:36.56881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.876574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:36.568862Z","caller":"traceutil/trace.go:171","msg":"trace[929263529] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1074; }","duration":"514.991557ms","start":"2026-05-19T00:08:36.053855Z","end":"2026-05-19T00:08:36.568846Z","steps":["trace[929263529] 'agreement among raft nodes before linearized reading' (duration: 514.885164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:36.568892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:35.99474Z","time spent":"574.053337ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:08:36.568921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:36.053833Z","time spent":"515.065268ms","remote":"127.0.0.1:45564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T00:08:36.568975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.559831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:36.56905Z","caller":"traceutil/trace.go:171","msg":"trace[344194755] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1074; }","duration":"405.689704ms","start":"2026-05-19T00:08:36.163342Z","end":"2026-05-19T00:08:36.569032Z","steps":["trace[344194755] 'agreement among raft nodes before linearized reading' (duration: 405.5416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:36.569094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:36.163321Z","time spent":"405.764746ms","remote":"127.0.0.1:60564","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-05-19T00:08:38.939213Z","caller":"traceutil/trace.go:171","msg":"trace[1779291663] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"263.72979ms","start":"2026-05-19T00:08:38.675461Z","end":"2026-05-19T00:08:38.939191Z","steps":["trace[1779291663] 'read index received' (duration: 263.530665ms)","trace[1779291663] 'applied index is now lower than readState.Index' (duration: 198.065µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:38.939278Z","caller":"traceutil/trace.go:171","msg":"trace[1945474449] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"364.920917ms","start":"2026-05-19T00:08:38.574313Z","end":"2026-05-19T00:08:38.939234Z","steps":["trace[1945474449] 'process raft request' (duration: 364.692062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:38.93945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.985065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-19T00:08:38.939443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:38.574288Z","time spent":"365.05841ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:08:38.939492Z","caller":"traceutil/trace.go:171","msg":"trace[1552705874] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1080; }","duration":"264.096567ms","start":"2026-05-19T00:08:38.675384Z","end":"2026-05-19T00:08:38.93948Z","steps":["trace[1552705874] 'agreement among raft nodes before linearized reading' (duration: 263.941664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:38.939647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.353257ms","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-05-19T00:08:38.93971Z","caller":"traceutil/trace.go:171","msg":"trace[2039471453] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1080; }","duration":"236.511171ms","start":"2026-05-19T00:08:38.703183Z","end":"2026-05-19T00:08:38.939694Z","steps":["trace[2039471453] 'agreement among raft nodes before linearized reading' (duration: 236.338197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:38.939673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.043789ms","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-05-19T00:08:38.94106Z","caller":"traceutil/trace.go:171","msg":"trace[380090755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1080; }","duration":"255.450192ms","start":"2026-05-19T00:08:38.685596Z","end":"2026-05-19T00:08:38.941046Z","steps":["trace[380090755] 'agreement among raft nodes before linearized reading' (duration: 253.821025ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:49.815178Z","caller":"traceutil/trace.go:171","msg":"trace[1348181205] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"212.218809ms","start":"2026-05-19T00:08:49.602928Z","end":"2026-05-19T00:08:49.815147Z","steps":["trace[1348181205] 'process raft request' (duration: 212.160348ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:49.815202Z","caller":"traceutil/trace.go:171","msg":"trace[1721729807] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"213.11465ms","start":"2026-05-19T00:08:49.602063Z","end":"2026-05-19T00:08:49.815178Z","steps":["trace[1721729807] 'process raft request' (duration: 212.894515ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:49.955239Z","caller":"traceutil/trace.go:171","msg":"trace[1154751541] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"100.794519ms","start":"2026-05-19T00:08:49.85442Z","end":"2026-05-19T00:08:49.955215Z","steps":["trace[1154751541] 'process raft request' (duration: 100.747258ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:49.955318Z","caller":"traceutil/trace.go:171","msg":"trace[95464414] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"101.414913ms","start":"2026-05-19T00:08:49.853871Z","end":"2026-05-19T00:08:49.955286Z","steps":["trace[95464414] 'process raft request' (duration: 55.964911ms)","trace[95464414] 'compare' (duration: 45.178676ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:50.136284Z","caller":"traceutil/trace.go:171","msg":"trace[1810239982] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"105.717432ms","start":"2026-05-19T00:08:50.030546Z","end":"2026-05-19T00:08:50.136264Z","steps":["trace[1810239982] 'process raft request' (duration: 104.932284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:50.371749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.28692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:08:50.371858Z","caller":"traceutil/trace.go:171","msg":"trace[1185918367] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"159.587054ms","start":"2026-05-19T00:08:50.212252Z","end":"2026-05-19T00:08:50.371839Z","steps":["trace[1185918367] 'process raft request' (duration: 25.062699ms)","trace[1185918367] 'compare' (duration: 134.143277ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:50.398579Z","caller":"traceutil/trace.go:171","msg":"trace[871817274] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"182.934805ms","start":"2026-05-19T00:08:50.215627Z","end":"2026-05-19T00:08:50.398562Z","steps":["trace[871817274] 'process raft request' (duration: 182.852743ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:51.335847Z","caller":"traceutil/trace.go:171","msg":"trace[57190819] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"193.950474ms","start":"2026-05-19T00:08:51.141868Z","end":"2026-05-19T00:08:51.335818Z","steps":["trace[57190819] 'process raft request' (duration: 101.524555ms)","trace[57190819] 'compare' (duration: 92.225205ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:51.335989Z","caller":"traceutil/trace.go:171","msg":"trace[1137110302] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1216; }","duration":"174.370739ms","start":"2026-05-19T00:08:51.161592Z","end":"2026-05-19T00:08:51.335962Z","steps":["trace[1137110302] 'read index received' (duration: 49.812871ms)","trace[1137110302] 'applied index is now lower than readState.Index' (duration: 124.556698ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:51.336174Z","caller":"traceutil/trace.go:171","msg":"trace[2056331142] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"193.008924ms","start":"2026-05-19T00:08:51.143154Z","end":"2026-05-19T00:08:51.336163Z","steps":["trace[2056331142] 'process raft request' (duration: 192.623345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:51.336324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.737208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:51.336355Z","caller":"traceutil/trace.go:171","msg":"trace[424625969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1172; }","duration":"174.781609ms","start":"2026-05-19T00:08:51.161563Z","end":"2026-05-19T00:08:51.336345Z","steps":["trace[424625969] 'agreement among raft nodes before linearized reading' (duration: 174.715478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:51.336531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.069298ms","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-05-19T00:08:51.336574Z","caller":"traceutil/trace.go:171","msg":"trace[1203664637] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1172; }","duration":"109.161869ms","start":"2026-05-19T00:08:51.227399Z","end":"2026-05-19T00:08:51.336561Z","steps":["trace[1203664637] 'agreement among raft nodes before linearized reading' (duration: 109.016926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:10.093447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.021101ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:09:10.093585Z","caller":"traceutil/trace.go:171","msg":"trace[2028541008] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"629.846161ms","start":"2026-05-19T00:09:09.463717Z","end":"2026-05-19T00:09:10.093563Z","steps":["trace[2028541008] 'process raft request' (duration: 253.617975ms)","trace[2028541008] 'compare' (duration: 375.546961ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:09:10.093665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:09.463703Z","time spent":"629.916523ms","remote":"127.0.0.1:60830","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-05-19T00:09:11.276477Z","caller":"traceutil/trace.go:171","msg":"trace[629477040] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"234.320571ms","start":"2026-05-19T00:09:11.042134Z","end":"2026-05-19T00:09:11.276455Z","steps":["trace[629477040] 'process raft request' (duration: 234.179837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:12.188781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.450677ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:09:12.188877Z","caller":"traceutil/trace.go:171","msg":"trace[160785389] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1309; }","duration":"1.026161089s","start":"2026-05-19T00:09:11.1627Z","end":"2026-05-19T00:09:12.188861Z","steps":["trace[160785389] 'read index received' (duration: 114.521565ms)","trace[160785389] 'applied index is now lower than readState.Index' (duration: 911.638054ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:09:12.188993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026298772s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:09:12.188978Z","caller":"traceutil/trace.go:171","msg":"trace[88372768] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"1.097517161s","start":"2026-05-19T00:09:11.091433Z","end":"2026-05-19T00:09:12.18895Z","steps":["trace[88372768] 'process raft request' (duration: 685.825429ms)","trace[88372768] 'compare' (duration: 411.221392ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:09:12.189024Z","caller":"traceutil/trace.go:171","msg":"trace[894272219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1259; }","duration":"1.026359474s","start":"2026-05-19T00:09:11.162654Z","end":"2026-05-19T00:09:12.189013Z","steps":["trace[894272219] 'agreement among raft nodes before linearized reading' (duration: 1.026306363s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:12.189057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:11.162636Z","time spent":"1.026414465s","remote":"127.0.0.1:60564","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-05-19T00:09:12.189115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:11.091416Z","time spent":"1.097626683s","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:09:12.189246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.672309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-19T00:09:12.189263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.233901ms","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-05-19T00:09:12.189337Z","caller":"traceutil/trace.go:171","msg":"trace[706229889] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1259; }","duration":"663.763802ms","start":"2026-05-19T00:09:11.525523Z","end":"2026-05-19T00:09:12.189287Z","steps":["trace[706229889] 'agreement among raft nodes before linearized reading' (duration: 663.6602ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:12.18935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.306053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-19T00:09:12.18938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:11.525512Z","time spent":"663.856314ms","remote":"127.0.0.1:45632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-05-19T00:09:12.189387Z","caller":"traceutil/trace.go:171","msg":"trace[1802539914] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1259; }","duration":"757.336864ms","start":"2026-05-19T00:09:11.432038Z","end":"2026-05-19T00:09:12.189375Z","steps":["trace[1802539914] 'agreement among raft nodes before linearized reading' (duration: 757.269813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:12.189397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.595157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-19T00:09:12.189421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:11.432006Z","time spent":"757.405476ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T00:09:12.189407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.113528ms","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-05-19T00:09:12.189455Z","caller":"traceutil/trace.go:171","msg":"trace[1960909761] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1259; }","duration":"746.70684ms","start":"2026-05-19T00:09:11.442734Z","end":"2026-05-19T00:09:12.189441Z","steps":["trace[1960909761] 'agreement among raft nodes before linearized reading' (duration: 746.456694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:12.18945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.132318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T00:09:12.189468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.616812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T00:09:12.189316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.745105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-19T00:09:12.189486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:11.442712Z","time spent":"746.76921ms","remote":"127.0.0.1:60830","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-05-19T00:09:12.18949Z","caller":"traceutil/trace.go:171","msg":"trace[906718734] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1259; }","duration":"620.190118ms","start":"2026-05-19T00:09:11.569287Z","end":"2026-05-19T00:09:12.189478Z","steps":["trace[906718734] 'agreement among raft nodes before linearized reading' (duration: 620.137437ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:09:12.189489Z","caller":"traceutil/trace.go:171","msg":"trace[617037866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1259; }","duration":"727.216711ms","start":"2026-05-19T00:09:11.462253Z","end":"2026-05-19T00:09:12.18947Z","steps":["trace[617037866] 'agreement among raft nodes before linearized reading' (duration: 726.962285ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:09:12.189515Z","caller":"traceutil/trace.go:171","msg":"trace[406960208] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1259; }","duration":"784.690654ms","start":"2026-05-19T00:09:11.404808Z","end":"2026-05-19T00:09:12.189498Z","steps":["trace[406960208] 'agreement among raft nodes before linearized reading' (duration: 784.624532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:12.189523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:11.569274Z","time spent":"620.24063ms","remote":"127.0.0.1:45532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-19T00:09:12.189523Z","caller":"traceutil/trace.go:171","msg":"trace[1342899154] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1259; }","duration":"140.039032ms","start":"2026-05-19T00:09:12.049469Z","end":"2026-05-19T00:09:12.189508Z","steps":["trace[1342899154] 'agreement among raft nodes before linearized reading' (duration: 139.730905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:12.189534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:11.462242Z","time spent":"727.281662ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T00:09:12.189551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:11.404796Z","time spent":"784.746045ms","remote":"127.0.0.1:45726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-19T00:09:12.189599Z","caller":"traceutil/trace.go:171","msg":"trace[211947717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1259; }","duration":"893.286232ms","start":"2026-05-19T00:09:11.296019Z","end":"2026-05-19T00:09:12.189305Z","steps":["trace[211947717] 'agreement among raft nodes before linearized reading' (duration: 893.16168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:12.189618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:11.296001Z","time spent":"893.61136ms","remote":"127.0.0.1:60830","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-05-19T00:09:12.328583Z","caller":"traceutil/trace.go:171","msg":"trace[710453910] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"135.348544ms","start":"2026-05-19T00:09:12.193218Z","end":"2026-05-19T00:09:12.328566Z","steps":["trace[710453910] 'process raft request' (duration: 102.010957ms)","trace[710453910] 'compare' (duration: 33.226675ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:09:12.328817Z","caller":"traceutil/trace.go:171","msg":"trace[1359873276] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"135.129469ms","start":"2026-05-19T00:09:12.193661Z","end":"2026-05-19T00:09:12.328791Z","steps":["trace[1359873276] 'process raft request' (duration: 134.881994ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:09:12.328889Z","caller":"traceutil/trace.go:171","msg":"trace[1760522253] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1310; }","duration":"129.414008ms","start":"2026-05-19T00:09:12.199459Z","end":"2026-05-19T00:09:12.328873Z","steps":["trace[1760522253] 'read index received' (duration: 95.707193ms)","trace[1760522253] 'applied index is now lower than readState.Index' (duration: 33.706105ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:09:12.328912Z","caller":"traceutil/trace.go:171","msg":"trace[2117785393] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"135.069228ms","start":"2026-05-19T00:09:12.193831Z","end":"2026-05-19T00:09:12.3289Z","steps":["trace[2117785393] 'process raft request' (duration: 134.963195ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:09:12.328969Z","caller":"traceutil/trace.go:171","msg":"trace[372785234] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"135.041857ms","start":"2026-05-19T00:09:12.193919Z","end":"2026-05-19T00:09:12.32896Z","steps":["trace[372785234] 'process raft request' (duration: 134.893994ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:09:12.329054Z","caller":"traceutil/trace.go:171","msg":"trace[191914624] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"135.371305ms","start":"2026-05-19T00:09:12.193672Z","end":"2026-05-19T00:09:12.329044Z","steps":["trace[191914624] 'process raft request' (duration: 135.053188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:12.329274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.803167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:09:12.329301Z","caller":"traceutil/trace.go:171","msg":"trace[974911782] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1265; }","duration":"129.840147ms","start":"2026-05-19T00:09:12.199451Z","end":"2026-05-19T00:09:12.329292Z","steps":["trace[974911782] 'agreement among raft nodes before linearized reading' (duration: 129.792066ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:09:24.616093Z","caller":"traceutil/trace.go:171","msg":"trace[820330309] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"419.929752ms","start":"2026-05-19T00:09:24.196141Z","end":"2026-05-19T00:09:24.616071Z","steps":["trace[820330309] 'process raft request' (duration: 419.786889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:24.616235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:24.19612Z","time spent":"420.046014ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:09:25.285746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.830001ms","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-05-19T00:09:25.285896Z","caller":"traceutil/trace.go:171","msg":"trace[2060115764] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1345; }","duration":"293.999554ms","start":"2026-05-19T00:09:24.991871Z","end":"2026-05-19T00:09:25.285871Z","steps":["trace[2060115764] 'range keys from in-memory index tree' (duration: 293.80838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:25.286544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.64656ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:09:25.286968Z","caller":"traceutil/trace.go:171","msg":"trace[1264574072] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"1.028244309s","start":"2026-05-19T00:09:24.258704Z","end":"2026-05-19T00:09:25.286948Z","steps":["trace[1264574072] 'process raft request' (duration: 869.048165ms)","trace[1264574072] 'compare' (duration: 157.791991ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:09:25.287087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:24.258677Z","time spent":"1.02834381s","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:09:25.356843Z","caller":"traceutil/trace.go:171","msg":"trace[474290028] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"447.590958ms","start":"2026-05-19T00:09:24.909232Z","end":"2026-05-19T00:09:25.356823Z","steps":["trace[474290028] 'process raft request' (duration: 447.428384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:25.357038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:24.909211Z","time spent":"447.758713ms","remote":"127.0.0.1:60740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6758,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:09:25.356845Z","caller":"traceutil/trace.go:171","msg":"trace[1341223190] linearizableReadLoop","detail":"{readStateIndex:1400; appliedIndex:1397; }","duration":"977.142873ms","start":"2026-05-19T00:09:24.379673Z","end":"2026-05-19T00:09:25.356816Z","steps":["trace[1341223190] 'read index received' (duration: 236.251516ms)","trace[1341223190] 'applied index is now lower than readState.Index' (duration: 740.886827ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:09:25.357428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.880888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-19T00:09:25.357428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.738657ms","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-05-19T00:09:25.357466Z","caller":"traceutil/trace.go:171","msg":"trace[1082159045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1347; }","duration":"976.957849ms","start":"2026-05-19T00:09:24.380497Z","end":"2026-05-19T00:09:25.357455Z","steps":["trace[1082159045] 'agreement among raft nodes before linearized reading' (duration: 976.846656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:25.357493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:24.380482Z","time spent":"977.00543ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T00:09:25.357502Z","caller":"traceutil/trace.go:171","msg":"trace[1199293745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1347; }","duration":"977.838369ms","start":"2026-05-19T00:09:24.379623Z","end":"2026-05-19T00:09:25.357462Z","steps":["trace[1199293745] 'agreement among raft nodes before linearized reading' (duration: 977.275456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:25.357513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.895479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-19T00:09:25.357544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.813777ms","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-05-19T00:09:25.357589Z","caller":"traceutil/trace.go:171","msg":"trace[658487758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1347; }","duration":"970.985811ms","start":"2026-05-19T00:09:24.386585Z","end":"2026-05-19T00:09:25.357571Z","steps":["trace[658487758] 'agreement among raft nodes before linearized reading' (duration: 970.789437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:25.357636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:24.38655Z","time spent":"971.078124ms","remote":"127.0.0.1:60830","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-05-19T00:09:25.357649Z","caller":"traceutil/trace.go:171","msg":"trace[1558751779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1347; }","duration":"973.941979ms","start":"2026-05-19T00:09:24.38367Z","end":"2026-05-19T00:09:25.357612Z","steps":["trace[1558751779] 'agreement among raft nodes before linearized reading' (duration: 973.706364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:25.357676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.6759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-19T00:09:25.357717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:24.383661Z","time spent":"974.046631ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T00:09:25.357769Z","caller":"traceutil/trace.go:171","msg":"trace[1621038044] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1347; }","duration":"480.835863ms","start":"2026-05-19T00:09:24.876913Z","end":"2026-05-19T00:09:25.357749Z","steps":["trace[1621038044] 'agreement among raft nodes before linearized reading' (duration: 480.658179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:25.357786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:24.379601Z","time spent":"978.023573ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T00:09:25.357823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:24.876893Z","time spent":"480.917916ms","remote":"127.0.0.1:60952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-05-19T00:09:25.357698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.883481ms","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-05-19T00:09:25.3579Z","caller":"traceutil/trace.go:171","msg":"trace[1579090921] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1347; }","duration":"975.140777ms","start":"2026-05-19T00:09:24.382751Z","end":"2026-05-19T00:09:25.357892Z","steps":["trace[1579090921] 'agreement among raft nodes before linearized reading' (duration: 974.807889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:09:25.357932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:24.382732Z","time spent":"975.192248ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-19T00:09:25.52271Z","caller":"traceutil/trace.go:171","msg":"trace[1722596269] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"159.894389ms","start":"2026-05-19T00:09:25.362779Z","end":"2026-05-19T00:09:25.522673Z","steps":["trace[1722596269] 'process raft request' (duration: 159.812377ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:09:25.522743Z","caller":"traceutil/trace.go:171","msg":"trace[621692543] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"160.214986ms","start":"2026-05-19T00:09:25.362493Z","end":"2026-05-19T00:09:25.522708Z","steps":["trace[621692543] 'process raft request' (duration: 159.945109ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:09:25.523397Z","caller":"traceutil/trace.go:171","msg":"trace[1908027811] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"159.808147ms","start":"2026-05-19T00:09:25.363571Z","end":"2026-05-19T00:09:25.523379Z","steps":["trace[1908027811] 'process raft request' (duration: 159.548771ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:09:25.523411Z","caller":"traceutil/trace.go:171","msg":"trace[29569815] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"160.093973ms","start":"2026-05-19T00:09:25.363234Z","end":"2026-05-19T00:09:25.523328Z","steps":["trace[29569815] 'process raft request' (duration: 159.399017ms)"],"step_count":1}