{"level":"warn","ts":"2026-06-22T18:18:17.694135Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T18:18:17.694248Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-06-22T18:18:17.694316Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T18:18:17.694324Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-06-22T18:18:17.694342Z","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-06-22T18:18:17.694979Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-06-22T18:18:17.69506Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-06-22T18:18:17.697271Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.02979ms"} {"level":"info","ts":"2026-06-22T18:18:17.701729Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-06-22T18:18:17.701796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-06-22T18:18:17.701812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-06-22T18:18:17.701824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-22T18:18:17.701834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-06-22T18:18:17.701869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-06-22T18:18:17.706146Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-22T18:18:17.708051Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-22T18:18:17.709381Z","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-06-22T18:18:17.71148Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-22T18:18:17.712553Z","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-06-22T18:18:17.712707Z","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-06-22T18:18:17.712729Z","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-06-22T18:18:17.713226Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-22T18:18:17.71358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-06-22T18:18:17.713702Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-06-22T18:18:17.716632Z","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-06-22T18:18:17.716739Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-06-22T18:18:17.716792Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-06-22T18:18:17.716891Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-22T18:18:17.716921Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-22T18:18:18.502141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-06-22T18:18:18.502182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-22T18:18:18.502203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-06-22T18:18:18.502214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-06-22T18:18:18.502219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-06-22T18:18:18.502227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-06-22T18:18:18.502233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-06-22T18:18:18.50316Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-06-22T18:18:18.503176Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T18:18:18.503212Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T18:18:18.503216Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:18:18.504284Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:18:18.504386Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:18:18.504418Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T18:18:18.506326Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-22T18:18:18.511304Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-22T18:18:18.511374Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-22T18:18:18.511042Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-06-22T18:18:45.922068Z","caller":"traceutil/trace.go:171","msg":"trace[222137465] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"132.270479ms","start":"2026-06-22T18:18:45.789778Z","end":"2026-06-22T18:18:45.922048Z","steps":["trace[222137465] 'process raft request' (duration: 132.154506ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:18:50.099328Z","caller":"traceutil/trace.go:171","msg":"trace[1847541151] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"143.543986ms","start":"2026-06-22T18:18:49.955757Z","end":"2026-06-22T18:18:50.099301Z","steps":["trace[1847541151] 'process raft request' (duration: 143.319191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:18:53.609612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.423113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:18:53.609764Z","caller":"traceutil/trace.go:171","msg":"trace[660673590] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:482; }","duration":"423.656409ms","start":"2026-06-22T18:18:53.186086Z","end":"2026-06-22T18:18:53.609743Z","steps":["trace[660673590] 'range keys from in-memory index tree' (duration: 423.352102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:18:53.609816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:18:53.186069Z","time spent":"423.733501ms","remote":"127.0.0.1:56160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-06-22T18:18:53.610565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.021884ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:18:53.610652Z","caller":"traceutil/trace.go:171","msg":"trace[2079416582] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"386.803233ms","start":"2026-06-22T18:18:53.223835Z","end":"2026-06-22T18:18:53.610638Z","steps":["trace[2079416582] 'process raft request' (duration: 148.797145ms)","trace[2079416582] 'compare' (duration: 236.876011ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:18:53.610716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:18:53.223807Z","time spent":"386.880705ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:18:54.260051Z","caller":"traceutil/trace.go:171","msg":"trace[1276093756] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"104.316662ms","start":"2026-06-22T18:18:54.155717Z","end":"2026-06-22T18:18:54.260034Z","steps":["trace[1276093756] 'process raft request' (duration: 104.129948ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:18:54.330151Z","caller":"traceutil/trace.go:171","msg":"trace[816882737] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"167.389563ms","start":"2026-06-22T18:18:54.162733Z","end":"2026-06-22T18:18:54.330122Z","steps":["trace[816882737] 'process raft request' (duration: 167.098786ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:18:54.330299Z","caller":"traceutil/trace.go:171","msg":"trace[1430371719] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"138.626265ms","start":"2026-06-22T18:18:54.191646Z","end":"2026-06-22T18:18:54.330273Z","steps":["trace[1430371719] 'process raft request' (duration: 138.40964ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:18:54.452841Z","caller":"traceutil/trace.go:171","msg":"trace[918082958] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"105.933293ms","start":"2026-06-22T18:18:54.346879Z","end":"2026-06-22T18:18:54.452812Z","steps":["trace[918082958] 'process raft request' (duration: 100.606652ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:18:59.838851Z","caller":"traceutil/trace.go:171","msg":"trace[1362979981] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"169.128586ms","start":"2026-06-22T18:18:59.669686Z","end":"2026-06-22T18:18:59.838815Z","steps":["trace[1362979981] 'process raft request' (duration: 168.954561ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:18:59.838836Z","caller":"traceutil/trace.go:171","msg":"trace[1280406052] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"138.670807ms","start":"2026-06-22T18:18:59.700136Z","end":"2026-06-22T18:18:59.838806Z","steps":["trace[1280406052] 'read index received' (duration: 138.431512ms)","trace[1280406052] 'applied index is now lower than readState.Index' (duration: 237.855µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:18:59.839019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.859242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:18:59.839083Z","caller":"traceutil/trace.go:171","msg":"trace[1428245334] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"138.976295ms","start":"2026-06-22T18:18:59.70009Z","end":"2026-06-22T18:18:59.839067Z","steps":["trace[1428245334] 'agreement among raft nodes before linearized reading' (duration: 138.831611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:00.448434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.307128ms","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-06-22T18:19:00.448535Z","caller":"traceutil/trace.go:171","msg":"trace[1033637435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"254.428911ms","start":"2026-06-22T18:19:00.194085Z","end":"2026-06-22T18:19:00.448514Z","steps":["trace[1033637435] 'range keys from in-memory index tree' (duration: 254.091002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:00.448485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.565413ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T18:19:00.448539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.57214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vznpq\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-06-22T18:19:00.44861Z","caller":"traceutil/trace.go:171","msg":"trace[922456005] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:587; }","duration":"348.703486ms","start":"2026-06-22T18:19:00.099886Z","end":"2026-06-22T18:19:00.448589Z","steps":["trace[922456005] 'range keys from in-memory index tree' (duration: 348.311537ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:00.44864Z","caller":"traceutil/trace.go:171","msg":"trace[1871077599] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vznpq; range_end:; response_count:1; response_revision:587; }","duration":"437.732485ms","start":"2026-06-22T18:19:00.010879Z","end":"2026-06-22T18:19:00.448611Z","steps":["trace[1871077599] 'range keys from in-memory index tree' (duration: 437.359486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:00.44869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:00.01086Z","time spent":"437.819426ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16980,"request content":"key:\"/registry/pods/kube-system/cilium-vznpq\" "} {"level":"warn","ts":"2026-06-22T18:19:00.448898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.65739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-22T18:19:00.448954Z","caller":"traceutil/trace.go:171","msg":"trace[1226313065] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"292.743082ms","start":"2026-06-22T18:19:00.156192Z","end":"2026-06-22T18:19:00.448935Z","steps":["trace[1226313065] 'range keys from in-memory index tree' (duration: 292.509106ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:00.528809Z","caller":"traceutil/trace.go:171","msg":"trace[1206965534] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"296.30057ms","start":"2026-06-22T18:19:00.232483Z","end":"2026-06-22T18:19:00.528784Z","steps":["trace[1206965534] 'process raft request' (duration: 295.709666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:01.200336Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312215362136622,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-22T18:19:01.700849Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312215362136622,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-22T18:19:02.054849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:00.796643Z","time spent":"1.258196753s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-22T18:19:02.055172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.418019359s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:19:02.055442Z","caller":"traceutil/trace.go:171","msg":"trace[1027697169] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"1.601850866s","start":"2026-06-22T18:19:00.453568Z","end":"2026-06-22T18:19:02.055418Z","steps":["trace[1027697169] 'process raft request' (duration: 183.5264ms)","trace[1027697169] 'compare' (duration: 1.417832814s)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:19:02.055503Z","caller":"traceutil/trace.go:171","msg":"trace[1861432797] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"1.592689971s","start":"2026-06-22T18:19:00.462796Z","end":"2026-06-22T18:19:02.055486Z","steps":["trace[1861432797] 'process raft request' (duration: 1.59262724s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:02.055602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:00.462773Z","time spent":"1.592796273s","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:19:02.055614Z","caller":"traceutil/trace.go:171","msg":"trace[1023448998] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"1.601840446s","start":"2026-06-22T18:19:00.453658Z","end":"2026-06-22T18:19:02.055499Z","steps":["trace[1023448998] 'process raft request' (duration: 1.601679742s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:02.055714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:00.453547Z","time spent":"1.601944589s","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:19:02.055755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:00.453632Z","time spent":"1.60205043s","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:19:02.131485Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.494856737s","expected-duration":"1s"} {"level":"info","ts":"2026-06-22T18:19:02.131825Z","caller":"traceutil/trace.go:171","msg":"trace[1052628008] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"1.544052886s","start":"2026-06-22T18:19:00.587748Z","end":"2026-06-22T18:19:02.131801Z","steps":["trace[1052628008] 'process raft request' (duration: 1.543914763s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:02.131951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:00.587729Z","time spent":"1.544162628s","remote":"127.0.0.1:56590","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-06-22T18:19:02.154219Z","caller":"traceutil/trace.go:171","msg":"trace[1679863367] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:614; }","duration":"1.454118197s","start":"2026-06-22T18:19:00.700003Z","end":"2026-06-22T18:19:02.154121Z","steps":["trace[1679863367] 'read index received' (duration: 1.431636474s)","trace[1679863367] 'applied index is now lower than readState.Index' (duration: 22.480563ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:19:02.154294Z","caller":"traceutil/trace.go:171","msg":"trace[686723418] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.085615122s","start":"2026-06-22T18:19:01.068658Z","end":"2026-06-22T18:19:02.154273Z","steps":["trace[686723418] 'process raft request' (duration: 1.084972687s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:02.154397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:01.068632Z","time spent":"1.085704494s","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:19:02.154476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.359218415s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-22T18:19:02.154523Z","caller":"traceutil/trace.go:171","msg":"trace[587707255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"1.359285806s","start":"2026-06-22T18:19:00.795223Z","end":"2026-06-22T18:19:02.154509Z","steps":["trace[587707255] 'agreement among raft nodes before linearized reading' (duration: 1.359128772s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:02.154568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:00.79521Z","time spent":"1.359342247s","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-22T18:19:02.154677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.631445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-06-22T18:19:02.154709Z","caller":"traceutil/trace.go:171","msg":"trace[1231996065] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:593; }","duration":"847.691427ms","start":"2026-06-22T18:19:01.307009Z","end":"2026-06-22T18:19:02.1547Z","steps":["trace[1231996065] 'agreement among raft nodes before linearized reading' (duration: 847.637435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:02.154783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:01.306988Z","time spent":"847.787919ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "} {"level":"warn","ts":"2026-06-22T18:19:02.154862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.612895ms","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-06-22T18:19:02.154908Z","caller":"traceutil/trace.go:171","msg":"trace[197244030] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"961.696407ms","start":"2026-06-22T18:19:01.193201Z","end":"2026-06-22T18:19:02.154897Z","steps":["trace[197244030] 'agreement among raft nodes before linearized reading' (duration: 961.581895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:02.154938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:01.193173Z","time spent":"961.758539ms","remote":"127.0.0.1:56320","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-06-22T18:19:02.154382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.454300511s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:19:02.155519Z","caller":"traceutil/trace.go:171","msg":"trace[1046462406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"1.455504221s","start":"2026-06-22T18:19:00.699958Z","end":"2026-06-22T18:19:02.155463Z","steps":["trace[1046462406] 'agreement among raft nodes before linearized reading' (duration: 1.45424139s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:02.156424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:00.699939Z","time spent":"1.455680225s","remote":"127.0.0.1:56066","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-06-22T18:19:02.783385Z","caller":"traceutil/trace.go:171","msg":"trace[259112620] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"102.262353ms","start":"2026-06-22T18:19:02.6811Z","end":"2026-06-22T18:19:02.783362Z","steps":["trace[259112620] 'process raft request' (duration: 102.062178ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:03.185735Z","caller":"traceutil/trace.go:171","msg":"trace[729425002] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"166.014419ms","start":"2026-06-22T18:19:03.019698Z","end":"2026-06-22T18:19:03.185712Z","steps":["trace[729425002] 'read index received' (duration: 165.779823ms)","trace[729425002] 'applied index is now lower than readState.Index' (duration: 233.496µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:19:03.185771Z","caller":"traceutil/trace.go:171","msg":"trace[1497893973] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"166.124921ms","start":"2026-06-22T18:19:03.019609Z","end":"2026-06-22T18:19:03.185734Z","steps":["trace[1497893973] 'process raft request' (duration: 165.962027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:03.18595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.231534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vznpq\" ","response":"range_response_count:1 size:17141"} {"level":"info","ts":"2026-06-22T18:19:03.185988Z","caller":"traceutil/trace.go:171","msg":"trace[1246542232] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vznpq; range_end:; response_count:1; response_revision:604; }","duration":"166.282395ms","start":"2026-06-22T18:19:03.019693Z","end":"2026-06-22T18:19:03.185975Z","steps":["trace[1246542232] 'agreement among raft nodes before linearized reading' (duration: 166.106401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:04.127279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.220941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vznpq\" ","response":"range_response_count:1 size:17239"} {"level":"info","ts":"2026-06-22T18:19:04.127354Z","caller":"traceutil/trace.go:171","msg":"trace[1041733709] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vznpq; range_end:; response_count:1; response_revision:608; }","duration":"102.368165ms","start":"2026-06-22T18:19:04.024968Z","end":"2026-06-22T18:19:04.127337Z","steps":["trace[1041733709] 'range keys from in-memory index tree' (duration: 102.038057ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:05.422171Z","caller":"traceutil/trace.go:171","msg":"trace[1889276903] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"282.653445ms","start":"2026-06-22T18:19:05.139494Z","end":"2026-06-22T18:19:05.422148Z","steps":["trace[1889276903] 'process raft request' (duration: 276.509263ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:05.435828Z","caller":"traceutil/trace.go:171","msg":"trace[1780124414] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"117.186749ms","start":"2026-06-22T18:19:05.318619Z","end":"2026-06-22T18:19:05.435806Z","steps":["trace[1780124414] 'process raft request' (duration: 116.895302ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:18.851514Z","caller":"traceutil/trace.go:171","msg":"trace[2137445082] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"255.949625ms","start":"2026-06-22T18:19:18.595537Z","end":"2026-06-22T18:19:18.851487Z","steps":["trace[2137445082] 'process raft request' (duration: 255.7742ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:19.359623Z","caller":"traceutil/trace.go:171","msg":"trace[417899637] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"232.422949ms","start":"2026-06-22T18:19:19.127175Z","end":"2026-06-22T18:19:19.359598Z","steps":["trace[417899637] 'process raft request' (duration: 232.286196ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:55.002393Z","caller":"traceutil/trace.go:171","msg":"trace[395144781] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1010; }","duration":"482.13946ms","start":"2026-06-22T18:19:54.520233Z","end":"2026-06-22T18:19:55.002373Z","steps":["trace[395144781] 'read index received' (duration: 482.015897ms)","trace[395144781] 'applied index is now lower than readState.Index' (duration: 120.373µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:19:55.002435Z","caller":"traceutil/trace.go:171","msg":"trace[976778746] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"651.074858ms","start":"2026-06-22T18:19:54.351344Z","end":"2026-06-22T18:19:55.002419Z","steps":["trace[976778746] 'process raft request' (duration: 650.865863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:55.002566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:54.351313Z","time spent":"651.178621ms","remote":"127.0.0.1:56320","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-06-22T18:19:55.002599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.363156ms","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-06-22T18:19:55.002629Z","caller":"traceutil/trace.go:171","msg":"trace[1330184841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:974; }","duration":"482.439757ms","start":"2026-06-22T18:19:54.52018Z","end":"2026-06-22T18:19:55.00262Z","steps":["trace[1330184841] 'agreement among raft nodes before linearized reading' (duration: 482.297714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:55.002655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:54.520153Z","time spent":"482.495459ms","remote":"127.0.0.1:56320","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-06-22T18:19:55.432903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.692966ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T18:19:55.433018Z","caller":"traceutil/trace.go:171","msg":"trace[843089750] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"697.389211ms","start":"2026-06-22T18:19:54.735613Z","end":"2026-06-22T18:19:55.433002Z","steps":["trace[843089750] 'process raft request' (duration: 331.531701ms)","trace[843089750] 'compare' (duration: 365.587133ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:19:55.433071Z","caller":"traceutil/trace.go:171","msg":"trace[309329985] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"426.956492ms","start":"2026-06-22T18:19:55.006103Z","end":"2026-06-22T18:19:55.43306Z","steps":["trace[309329985] 'process raft request' (duration: 426.894521ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:55.433084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:54.735586Z","time spent":"697.468702ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:19:55.433134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:55.006087Z","time spent":"427.017673ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:19:55.433214Z","caller":"traceutil/trace.go:171","msg":"trace[1822877027] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1011; }","duration":"430.745226ms","start":"2026-06-22T18:19:55.002459Z","end":"2026-06-22T18:19:55.433205Z","steps":["trace[1822877027] 'read index received' (duration: 64.704752ms)","trace[1822877027] 'applied index is now lower than readState.Index' (duration: 366.039554ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:19:55.43338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.152149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-22T18:19:55.433438Z","caller":"traceutil/trace.go:171","msg":"trace[908654037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:976; }","duration":"892.243931ms","start":"2026-06-22T18:19:54.541185Z","end":"2026-06-22T18:19:55.433429Z","steps":["trace[908654037] 'agreement among raft nodes before linearized reading' (duration: 892.129438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:55.43346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.315319ms","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":"warn","ts":"2026-06-22T18:19:55.43347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:54.541163Z","time spent":"892.296382ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-22T18:19:55.433489Z","caller":"traceutil/trace.go:171","msg":"trace[365016281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:976; }","duration":"397.369459ms","start":"2026-06-22T18:19:55.036111Z","end":"2026-06-22T18:19:55.433481Z","steps":["trace[365016281] 'agreement among raft nodes before linearized reading' (duration: 397.300918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:55.433575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:55.036097Z","time spent":"397.469202ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-22T18:19:55.433608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:19:55.433632Z","caller":"traceutil/trace.go:171","msg":"trace[1378016630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:976; }","duration":"733.067301ms","start":"2026-06-22T18:19:54.700559Z","end":"2026-06-22T18:19:55.433627Z","steps":["trace[1378016630] 'agreement among raft nodes before linearized reading' (duration: 733.02987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:55.433654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:54.700496Z","time spent":"733.152864ms","remote":"127.0.0.1:56066","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-06-22T18:19:55.433836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.05294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-22T18:19:55.433872Z","caller":"traceutil/trace.go:171","msg":"trace[717577712] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:976; }","duration":"879.103361ms","start":"2026-06-22T18:19:54.554762Z","end":"2026-06-22T18:19:55.433865Z","steps":["trace[717577712] 'agreement among raft nodes before linearized reading' (duration: 879.003768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:55.433894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:54.554756Z","time spent":"879.133671ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-22T18:19:55.43339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.774047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-22T18:19:55.43398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.551455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-22T18:19:55.433998Z","caller":"traceutil/trace.go:171","msg":"trace[1893518240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:976; }","duration":"880.584627ms","start":"2026-06-22T18:19:54.553409Z","end":"2026-06-22T18:19:55.433993Z","steps":["trace[1893518240] 'agreement among raft nodes before linearized reading' (duration: 880.534325ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:19:55.433995Z","caller":"traceutil/trace.go:171","msg":"trace[17298194] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:976; }","duration":"907.389301ms","start":"2026-06-22T18:19:54.526592Z","end":"2026-06-22T18:19:55.433981Z","steps":["trace[17298194] 'agreement among raft nodes before linearized reading' (duration: 906.763366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:19:55.434019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:54.553401Z","time spent":"880.613747ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-22T18:19:55.434039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:19:54.526584Z","time spent":"907.440232ms","remote":"127.0.0.1:56492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-06-22T18:20:03.640458Z","caller":"traceutil/trace.go:171","msg":"trace[1505029816] linearizableReadLoop","detail":"{readStateIndex:1043; appliedIndex:1042; }","duration":"145.620058ms","start":"2026-06-22T18:20:03.494817Z","end":"2026-06-22T18:20:03.640437Z","steps":["trace[1505029816] 'read index received' (duration: 115.984514ms)","trace[1505029816] 'applied index is now lower than readState.Index' (duration: 29.634854ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:20:03.640465Z","caller":"traceutil/trace.go:171","msg":"trace[2069319831] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"158.37037ms","start":"2026-06-22T18:20:03.482069Z","end":"2026-06-22T18:20:03.64044Z","steps":["trace[2069319831] 'process raft request' (duration: 128.721875ms)","trace[2069319831] 'compare' (duration: 29.524422ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:20:03.64062Z","caller":"traceutil/trace.go:171","msg":"trace[2120723277] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"143.105936ms","start":"2026-06-22T18:20:03.497483Z","end":"2026-06-22T18:20:03.640589Z","steps":["trace[2120723277] 'process raft request' (duration: 142.932782ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:03.640724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.761495ms","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-06-22T18:20:03.640776Z","caller":"traceutil/trace.go:171","msg":"trace[1592967671] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1005; }","duration":"157.843436ms","start":"2026-06-22T18:20:03.482922Z","end":"2026-06-22T18:20:03.640766Z","steps":["trace[1592967671] 'agreement among raft nodes before linearized reading' (duration: 157.604961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:16.861425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.161896ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-22T18:20:16.862213Z","caller":"traceutil/trace.go:171","msg":"trace[174052841] linearizableReadLoop","detail":"{readStateIndex:1088; appliedIndex:1087; }","duration":"160.542423ms","start":"2026-06-22T18:20:16.701023Z","end":"2026-06-22T18:20:16.861565Z","steps":["trace[174052841] 'read index received' (duration: 58.992µs)","trace[174052841] 'applied index is now lower than readState.Index' (duration: 160.481581ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:20:16.862311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.670385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:20:16.862372Z","caller":"traceutil/trace.go:171","msg":"trace[904671520] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1046; }","duration":"161.385564ms","start":"2026-06-22T18:20:16.700973Z","end":"2026-06-22T18:20:16.862359Z","steps":["trace[904671520] 'agreement among raft nodes before linearized reading' (duration: 160.668266ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:17.718216Z","caller":"traceutil/trace.go:171","msg":"trace[1870920732] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"167.162425ms","start":"2026-06-22T18:20:17.55103Z","end":"2026-06-22T18:20:17.718192Z","steps":["trace[1870920732] 'process raft request' (duration: 166.974981ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:17.718641Z","caller":"traceutil/trace.go:171","msg":"trace[846490783] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"167.545634ms","start":"2026-06-22T18:20:17.551068Z","end":"2026-06-22T18:20:17.718614Z","steps":["trace[846490783] 'process raft request' (duration: 167.084583ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:17.922637Z","caller":"traceutil/trace.go:171","msg":"trace[1553204373] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"200.52358ms","start":"2026-06-22T18:20:17.722087Z","end":"2026-06-22T18:20:17.922611Z","steps":["trace[1553204373] 'process raft request' (duration: 200.293774ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:17.939577Z","caller":"traceutil/trace.go:171","msg":"trace[1666385319] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"216.979141ms","start":"2026-06-22T18:20:17.722574Z","end":"2026-06-22T18:20:17.939553Z","steps":["trace[1666385319] 'process raft request' (duration: 216.9381ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:17.939603Z","caller":"traceutil/trace.go:171","msg":"trace[2037054778] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"217.292549ms","start":"2026-06-22T18:20:17.722297Z","end":"2026-06-22T18:20:17.939589Z","steps":["trace[2037054778] 'process raft request' (duration: 217.111014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:34.964054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.797263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:20:34.964139Z","caller":"traceutil/trace.go:171","msg":"trace[639960095] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1153; }","duration":"467.931216ms","start":"2026-06-22T18:20:34.49619Z","end":"2026-06-22T18:20:34.964122Z","steps":["trace[639960095] 'range keys from in-memory index tree' (duration: 467.67969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:34.964194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:34.496173Z","time spent":"468.010449ms","remote":"127.0.0.1:56066","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-06-22T18:20:34.964414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"979.882543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-22T18:20:34.96442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.162526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-22T18:20:34.964444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.834415ms","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-06-22T18:20:34.964461Z","caller":"traceutil/trace.go:171","msg":"trace[1358351603] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1153; }","duration":"979.956694ms","start":"2026-06-22T18:20:33.984495Z","end":"2026-06-22T18:20:34.964451Z","steps":["trace[1358351603] 'range keys from in-memory index tree' (duration: 979.691658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:34.96402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.548379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:20:34.964503Z","caller":"traceutil/trace.go:171","msg":"trace[1081967144] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1153; }","duration":"959.924788ms","start":"2026-06-22T18:20:34.004565Z","end":"2026-06-22T18:20:34.964489Z","steps":["trace[1081967144] 'range keys from in-memory index tree' (duration: 959.672201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:34.964512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:33.984479Z","time spent":"980.023816ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-22T18:20:34.964498Z","caller":"traceutil/trace.go:171","msg":"trace[1813715939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1153; }","duration":"963.295749ms","start":"2026-06-22T18:20:34.001184Z","end":"2026-06-22T18:20:34.96448Z","steps":["trace[1813715939] 'range keys from in-memory index tree' (duration: 962.999762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:34.964542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:34.004553Z","time spent":"959.979329ms","remote":"127.0.0.1:56320","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-06-22T18:20:34.96453Z","caller":"traceutil/trace.go:171","msg":"trace[2066072736] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1153; }","duration":"612.126031ms","start":"2026-06-22T18:20:34.352383Z","end":"2026-06-22T18:20:34.964509Z","steps":["trace[2066072736] 'count revisions from in-memory index tree' (duration: 611.423575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:34.964553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:34.001166Z","time spent":"963.376861ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-22T18:20:34.964588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:34.352363Z","time spent":"612.208764ms","remote":"127.0.0.1:50928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-06-22T18:20:51.483444Z","caller":"traceutil/trace.go:171","msg":"trace[683981927] linearizableReadLoop","detail":"{readStateIndex:1279; appliedIndex:1278; }","duration":"168.551468ms","start":"2026-06-22T18:20:51.314869Z","end":"2026-06-22T18:20:51.483421Z","steps":["trace[683981927] 'read index received' (duration: 168.440885ms)","trace[683981927] 'applied index is now lower than readState.Index' (duration: 109.873µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:20:51.483592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.713571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-06-22T18:20:51.483625Z","caller":"traceutil/trace.go:171","msg":"trace[879553017] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:1229; }","duration":"168.789903ms","start":"2026-06-22T18:20:51.314827Z","end":"2026-06-22T18:20:51.483617Z","steps":["trace[879553017] 'agreement among raft nodes before linearized reading' (duration: 168.676721ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:51.48375Z","caller":"traceutil/trace.go:171","msg":"trace[636645472] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"182.991949ms","start":"2026-06-22T18:20:51.300732Z","end":"2026-06-22T18:20:51.483724Z","steps":["trace[636645472] 'process raft request' (duration: 182.577989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:52.119651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.19486ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-22T18:20:52.119893Z","caller":"traceutil/trace.go:171","msg":"trace[493219703] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1279; }","duration":"418.688199ms","start":"2026-06-22T18:20:51.701188Z","end":"2026-06-22T18:20:52.119877Z","steps":["trace[493219703] 'read index received' (duration: 113.252794ms)","trace[493219703] 'applied index is now lower than readState.Index' (duration: 305.433795ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:20:52.119894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:51.485071Z","time spent":"634.816394ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-22T18:20:52.120021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.10634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:20:52.120059Z","caller":"traceutil/trace.go:171","msg":"trace[441986552] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1229; }","duration":"380.191063ms","start":"2026-06-22T18:20:51.739857Z","end":"2026-06-22T18:20:52.120048Z","steps":["trace[441986552] 'agreement among raft nodes before linearized reading' (duration: 380.114351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:52.120061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.856393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T18:20:52.120101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:51.739837Z","time spent":"380.252795ms","remote":"127.0.0.1:50908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-22T18:20:52.120134Z","caller":"traceutil/trace.go:171","msg":"trace[421275563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1229; }","duration":"418.982946ms","start":"2026-06-22T18:20:51.701133Z","end":"2026-06-22T18:20:52.120116Z","steps":["trace[421275563] 'agreement among raft nodes before linearized reading' (duration: 418.827543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:52.120175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:51.701088Z","time spent":"419.079088ms","remote":"127.0.0.1:56066","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-06-22T18:20:52.120159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.619146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-22T18:20:52.120236Z","caller":"traceutil/trace.go:171","msg":"trace[1169161577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1229; }","duration":"230.75375ms","start":"2026-06-22T18:20:51.889466Z","end":"2026-06-22T18:20:52.12022Z","steps":["trace[1169161577] 'agreement among raft nodes before linearized reading' (duration: 230.512784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:52.120422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.140252ms","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-06-22T18:20:52.120461Z","caller":"traceutil/trace.go:171","msg":"trace[1687704207] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1229; }","duration":"236.218754ms","start":"2026-06-22T18:20:51.884232Z","end":"2026-06-22T18:20:52.120451Z","steps":["trace[1687704207] 'agreement among raft nodes before linearized reading' (duration: 236.08697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.231363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.841584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T18:20:53.231524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.201929ms","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-06-22T18:20:53.231635Z","caller":"traceutil/trace.go:171","msg":"trace[1555216342] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1234; }","duration":"103.412404ms","start":"2026-06-22T18:20:53.128212Z","end":"2026-06-22T18:20:53.231625Z","steps":["trace[1555216342] 'range keys from in-memory index tree' (duration: 103.044345ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:53.231584Z","caller":"traceutil/trace.go:171","msg":"trace[1486421152] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1234; }","duration":"308.119331ms","start":"2026-06-22T18:20:52.923451Z","end":"2026-06-22T18:20:53.231571Z","steps":["trace[1486421152] 'range keys from in-memory index tree' (duration: 307.748632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.231745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:52.923428Z","time spent":"308.304046ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-22T18:20:53.231615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.206875ms","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-06-22T18:20:53.231889Z","caller":"traceutil/trace.go:171","msg":"trace[2094923800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1234; }","duration":"109.533013ms","start":"2026-06-22T18:20:53.122335Z","end":"2026-06-22T18:20:53.231868Z","steps":["trace[2094923800] 'range keys from in-memory index tree' (duration: 109.02778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.232117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.114108ms","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-06-22T18:20:53.232168Z","caller":"traceutil/trace.go:171","msg":"trace[1254428925] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1234; }","duration":"152.169989ms","start":"2026-06-22T18:20:53.079984Z","end":"2026-06-22T18:20:53.232154Z","steps":["trace[1254428925] 'range keys from in-memory index tree' (duration: 151.972064ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:53.926982Z","caller":"traceutil/trace.go:171","msg":"trace[1481877149] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"689.717318ms","start":"2026-06-22T18:20:53.237241Z","end":"2026-06-22T18:20:53.926958Z","steps":["trace[1481877149] 'process raft request' (duration: 689.652267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.927104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.237226Z","time spent":"689.824362ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:20:53.927151Z","caller":"traceutil/trace.go:171","msg":"trace[1972531032] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1286; }","duration":"494.785209ms","start":"2026-06-22T18:20:53.432338Z","end":"2026-06-22T18:20:53.927123Z","steps":["trace[1972531032] 'read index received' (duration: 494.419571ms)","trace[1972531032] 'applied index is now lower than readState.Index' (duration: 364.568µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:20:53.927338Z","caller":"traceutil/trace.go:171","msg":"trace[901814042] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"691.882271ms","start":"2026-06-22T18:20:53.235443Z","end":"2026-06-22T18:20:53.927325Z","steps":["trace[901814042] 'process raft request' (duration: 691.277516ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:53.92739Z","caller":"traceutil/trace.go:171","msg":"trace[760708218] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"658.271194ms","start":"2026-06-22T18:20:53.269106Z","end":"2026-06-22T18:20:53.927377Z","steps":["trace[760708218] 'process raft request' (duration: 657.815093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.927424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.235421Z","time spent":"691.951233ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:20:53.927496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.269085Z","time spent":"658.342486ms","remote":"127.0.0.1:56148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:20:53.927577Z","caller":"traceutil/trace.go:171","msg":"trace[1108617700] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"691.769099ms","start":"2026-06-22T18:20:53.235796Z","end":"2026-06-22T18:20:53.927565Z","steps":["trace[1108617700] 'process raft request' (duration: 691.054671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.927639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.235785Z","time spent":"691.82512ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:20:53.927734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.399115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:20:53.927776Z","caller":"traceutil/trace.go:171","msg":"trace[1791959902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1239; }","duration":"495.478047ms","start":"2026-06-22T18:20:53.432286Z","end":"2026-06-22T18:20:53.927764Z","steps":["trace[1791959902] 'agreement among raft nodes before linearized reading' (duration: 495.413325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:53.927808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.432266Z","time spent":"495.536458ms","remote":"127.0.0.1:56066","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-06-22T18:20:54.189837Z","caller":"traceutil/trace.go:171","msg":"trace[2108005887] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"262.596735ms","start":"2026-06-22T18:20:53.927217Z","end":"2026-06-22T18:20:54.189813Z","steps":["trace[2108005887] 'read index received' (duration: 211.535073ms)","trace[2108005887] 'applied index is now lower than readState.Index' (duration: 51.060702ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:20:54.18987Z","caller":"traceutil/trace.go:171","msg":"trace[679699988] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"701.150866ms","start":"2026-06-22T18:20:53.488688Z","end":"2026-06-22T18:20:54.189839Z","steps":["trace[679699988] 'process raft request' (duration: 649.968092ms)","trace[679699988] 'compare' (duration: 51.039861ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:20:54.189964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.541462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:20:54.189998Z","caller":"traceutil/trace.go:171","msg":"trace[933285397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1240; }","duration":"489.622374ms","start":"2026-06-22T18:20:53.700365Z","end":"2026-06-22T18:20:54.189988Z","steps":["trace[933285397] 'agreement among raft nodes before linearized reading' (duration: 489.555742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:54.190037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.700347Z","time spent":"489.682405ms","remote":"127.0.0.1:56062","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-06-22T18:20:54.190031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.309153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T18:20:54.190101Z","caller":"traceutil/trace.go:171","msg":"trace[316980332] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1240; }","duration":"734.428476ms","start":"2026-06-22T18:20:53.455654Z","end":"2026-06-22T18:20:54.190083Z","steps":["trace[316980332] 'agreement among raft nodes before linearized reading' (duration: 734.312223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:54.189974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.488665Z","time spent":"701.251779ms","remote":"127.0.0.1:56320","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-06-22T18:20:54.190155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.455634Z","time spent":"734.510698ms","remote":"127.0.0.1:46702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-06-22T18:20:54.455681Z","caller":"traceutil/trace.go:171","msg":"trace[710563621] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"518.472566ms","start":"2026-06-22T18:20:53.937185Z","end":"2026-06-22T18:20:54.455658Z","steps":["trace[710563621] 'process raft request' (duration: 518.426055ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:20:54.455709Z","caller":"traceutil/trace.go:171","msg":"trace[1362914863] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"523.851866ms","start":"2026-06-22T18:20:53.931826Z","end":"2026-06-22T18:20:54.455677Z","steps":["trace[1362914863] 'process raft request' (duration: 445.266666ms)","trace[1362914863] 'compare' (duration: 78.379336ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:20:54.455817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.93181Z","time spent":"523.951218ms","remote":"127.0.0.1:56148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T18:20:54.455819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.937165Z","time spent":"518.591828ms","remote":"127.0.0.1:56148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T18:20:54.503613Z","caller":"traceutil/trace.go:171","msg":"trace[2060502890] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"357.012469ms","start":"2026-06-22T18:20:54.146587Z","end":"2026-06-22T18:20:54.503599Z","steps":["trace[2060502890] 'process raft request' (duration: 356.809184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:54.503725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:54.146561Z","time spent":"357.101412ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T18:20:54.50376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.439586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-22T18:20:54.50381Z","caller":"traceutil/trace.go:171","msg":"trace[14309999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1243; }","duration":"340.558399ms","start":"2026-06-22T18:20:54.163241Z","end":"2026-06-22T18:20:54.503799Z","steps":["trace[14309999] 'agreement among raft nodes before linearized reading' (duration: 340.365124ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:54.503806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.80489ms","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-06-22T18:20:54.503834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:54.163228Z","time spent":"340.60071ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-22T18:20:54.503549Z","caller":"traceutil/trace.go:171","msg":"trace[1549499190] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1291; }","duration":"313.631675ms","start":"2026-06-22T18:20:54.189898Z","end":"2026-06-22T18:20:54.50353Z","steps":["trace[1549499190] 'read index received' (duration: 187.409896ms)","trace[1549499190] 'applied index is now lower than readState.Index' (duration: 126.220679ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:20:54.503871Z","caller":"traceutil/trace.go:171","msg":"trace[1398826683] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1243; }","duration":"341.929383ms","start":"2026-06-22T18:20:54.161923Z","end":"2026-06-22T18:20:54.503852Z","steps":["trace[1398826683] 'agreement among raft nodes before linearized reading' (duration: 341.715698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:54.503909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:54.161901Z","time spent":"342.000354ms","remote":"127.0.0.1:56320","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-06-22T18:20:54.503938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.779046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-22T18:20:54.503995Z","caller":"traceutil/trace.go:171","msg":"trace[621525282] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1243; }","duration":"570.858128ms","start":"2026-06-22T18:20:53.933124Z","end":"2026-06-22T18:20:54.503982Z","steps":["trace[621525282] 'agreement among raft nodes before linearized reading' (duration: 570.682534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:20:54.504033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:20:53.933118Z","time spent":"570.907499ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-22T18:20:55.421868Z","caller":"traceutil/trace.go:171","msg":"trace[2140727425] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"116.650796ms","start":"2026-06-22T18:20:55.305197Z","end":"2026-06-22T18:20:55.421848Z","steps":["trace[2140727425] 'process raft request' (duration: 116.528103ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:21:03.984891Z","caller":"traceutil/trace.go:171","msg":"trace[140380707] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"400.433266ms","start":"2026-06-22T18:21:03.5844Z","end":"2026-06-22T18:21:03.984834Z","steps":["trace[140380707] 'process raft request' (duration: 398.200981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:21:03.985037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T18:21:03.584379Z","time spent":"400.583249ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T18:21:04.234754Z","caller":"traceutil/trace.go:171","msg":"trace[1343964223] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"209.604606ms","start":"2026-06-22T18:21:04.025082Z","end":"2026-06-22T18:21:04.234686Z","steps":["trace[1343964223] 'read index received' (duration: 205.420184ms)","trace[1343964223] 'applied index is now lower than readState.Index' (duration: 4.183092ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T18:21:04.234961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.855682ms","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-06-22T18:21:04.234993Z","caller":"traceutil/trace.go:171","msg":"trace[729533583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1312; }","duration":"209.927394ms","start":"2026-06-22T18:21:04.025056Z","end":"2026-06-22T18:21:04.234983Z","steps":["trace[729533583] 'agreement among raft nodes before linearized reading' (duration: 209.76588ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:21:04.235026Z","caller":"traceutil/trace.go:171","msg":"trace[993288542] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"246.078662ms","start":"2026-06-22T18:21:03.988911Z","end":"2026-06-22T18:21:04.23499Z","steps":["trace[993288542] 'process raft request' (duration: 241.571982ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:24:52.744308Z","caller":"traceutil/trace.go:171","msg":"trace[1218072046] transaction","detail":"{read_only:false; response_revision:2389; number_of_response:1; }","duration":"181.347376ms","start":"2026-06-22T18:24:52.562931Z","end":"2026-06-22T18:24:52.744278Z","steps":["trace[1218072046] 'process raft request' (duration: 181.11545ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T18:24:53.73581Z","caller":"traceutil/trace.go:171","msg":"trace[1997864492] linearizableReadLoop","detail":"{readStateIndex:2496; appliedIndex:2495; }","duration":"186.917991ms","start":"2026-06-22T18:24:53.548866Z","end":"2026-06-22T18:24:53.735784Z","steps":["trace[1997864492] 'read index received' (duration: 186.238105ms)","trace[1997864492] 'applied index is now lower than readState.Index' (duration: 678.766µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T18:24:53.735871Z","caller":"traceutil/trace.go:171","msg":"trace[1869169915] transaction","detail":"{read_only:false; number_of_response:1; response_revision:2396; }","duration":"242.881401ms","start":"2026-06-22T18:24:53.492964Z","end":"2026-06-22T18:24:53.735846Z","steps":["trace[1869169915] 'process raft request' (duration: 242.160734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T18:24:53.736071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.191918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2576"} {"level":"info","ts":"2026-06-22T18:24:53.736257Z","caller":"traceutil/trace.go:171","msg":"trace[1473842470] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:2396; }","duration":"187.2862ms","start":"2026-06-22T18:24:53.548823Z","end":"2026-06-22T18:24:53.736109Z","steps":["trace[1473842470] 'agreement among raft nodes before linearized reading' (duration: 187.098886ms)"],"step_count":1}