{"level":"warn","ts":"2026-04-20T02:05:20.118245Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T02:05:20.118366Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95: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.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95: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-04-20T02:05:20.118457Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T02:05:20.118476Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-04-20T02:05:20.1185Z","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-04-20T02:05:20.119336Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]} {"level":"info","ts":"2026-04-20T02:05:20.119481Z","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.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95: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-04-20T02:05:20.123585Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.809222ms"} {"level":"info","ts":"2026-04-20T02:05:20.128705Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"} {"level":"info","ts":"2026-04-20T02:05:20.12879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T02:05:20.128816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"} {"level":"info","ts":"2026-04-20T02:05:20.128828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T02:05:20.12884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"} {"level":"info","ts":"2026-04-20T02:05:20.128889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"warn","ts":"2026-04-20T02:05:20.141839Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T02:05:20.143953Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T02:05:20.14514Z","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-04-20T02:05:20.147988Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T02:05:20.148299Z","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-04-20T02:05:20.148763Z","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-04-20T02:05:20.148812Z","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-04-20T02:05:20.148279Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T02:05:20.155956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"info","ts":"2026-04-20T02:05:20.156178Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-04-20T02:05:20.156812Z","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-04-20T02:05:20.157024Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T02:05:20.157052Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T02:05:20.157162Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-04-20T02:05:20.15718Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-04-20T02:05:20.629499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T02:05:20.62958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T02:05:20.629628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"} {"level":"info","ts":"2026-04-20T02:05:20.629646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"} {"level":"info","ts":"2026-04-20T02:05:20.629654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-04-20T02:05:20.629665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"} {"level":"info","ts":"2026-04-20T02:05:20.629677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-04-20T02:05:20.63055Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T02:05:20.63079Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:05:20.631655Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T02:05:20.632016Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T02:05:20.632188Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T02:05:20.632206Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T02:05:20.632237Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:05:20.632358Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:05:20.632387Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T02:05:20.634337Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"} {"level":"info","ts":"2026-04-20T02:05:20.63548Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-20T02:05:25.897957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.3882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:25.89809Z","caller":"traceutil/trace.go:171","msg":"trace[2133976133] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-controller; range_end:; response_count:0; response_revision:297; }","duration":"303.581275ms","start":"2026-04-20T02:05:25.594485Z","end":"2026-04-20T02:05:25.898066Z","steps":["trace[2133976133] 'range keys from in-memory index tree' (duration: 303.272718ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:25.898046Z","caller":"traceutil/trace.go:171","msg":"trace[819439966] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"252.317697ms","start":"2026-04-20T02:05:25.6457Z","end":"2026-04-20T02:05:25.898018Z","steps":["trace[819439966] 'process raft request' (duration: 152.73097ms)","trace[819439966] 'compare' (duration: 99.462744ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:25.898138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:25.594462Z","time spent":"303.666708ms","remote":"127.0.0.1:35394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/service-controller\" "} {"level":"info","ts":"2026-04-20T02:05:26.121848Z","caller":"traceutil/trace.go:171","msg":"trace[1152303478] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"217.564995ms","start":"2026-04-20T02:05:25.904261Z","end":"2026-04-20T02:05:26.121826Z","steps":["trace[1152303478] 'process raft request' (duration: 217.516244ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:26.121855Z","caller":"traceutil/trace.go:171","msg":"trace[1105845989] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"219.547073ms","start":"2026-04-20T02:05:25.902277Z","end":"2026-04-20T02:05:26.121824Z","steps":["trace[1105845989] 'process raft request' (duration: 164.81346ms)","trace[1105845989] 'compare' (duration: 54.557529ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:05:26.121945Z","caller":"traceutil/trace.go:171","msg":"trace[1448873679] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:306; }","duration":"217.684037ms","start":"2026-04-20T02:05:25.904208Z","end":"2026-04-20T02:05:26.121892Z","steps":["trace[1448873679] 'read index received' (duration: 162.905934ms)","trace[1448873679] 'applied index is now lower than readState.Index' (duration: 54.773153ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:26.122191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.903322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:05:26.122265Z","caller":"traceutil/trace.go:171","msg":"trace[1609782124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:300; }","duration":"218.069977ms","start":"2026-04-20T02:05:25.904176Z","end":"2026-04-20T02:05:26.122246Z","steps":["trace[1609782124] 'agreement among raft nodes before linearized reading' (duration: 217.854832ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:55.926826Z","caller":"traceutil/trace.go:171","msg":"trace[1631245600] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"166.590955ms","start":"2026-04-20T02:05:55.760164Z","end":"2026-04-20T02:05:55.926755Z","steps":["trace[1631245600] 'process raft request' (duration: 88.500341ms)","trace[1631245600] 'compare' (duration: 77.813098ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:56.684373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.571895ms","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-04-20T02:05:56.684484Z","caller":"traceutil/trace.go:171","msg":"trace[1244579690] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:614; }","duration":"588.677837ms","start":"2026-04-20T02:05:56.095775Z","end":"2026-04-20T02:05:56.684453Z","steps":["trace[1244579690] 'range keys from in-memory index tree' (duration: 588.557734ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:56.690297Z","caller":"traceutil/trace.go:171","msg":"trace[582794263] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"327.406473ms","start":"2026-04-20T02:05:56.362872Z","end":"2026-04-20T02:05:56.690279Z","steps":["trace[582794263] 'read index received' (duration: 325.871666ms)","trace[582794263] 'applied index is now lower than readState.Index' (duration: 1.534047ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:05:56.691104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.212392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tvh4t\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-20T02:05:56.691258Z","caller":"traceutil/trace.go:171","msg":"trace[643723058] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tvh4t; range_end:; response_count:1; response_revision:615; }","duration":"328.344045ms","start":"2026-04-20T02:05:56.362827Z","end":"2026-04-20T02:05:56.691171Z","steps":["trace[643723058] 'agreement among raft nodes before linearized reading' (duration: 327.537206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:56.691441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:56.362807Z","time spent":"328.53445ms","remote":"127.0.0.1:35378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-tvh4t\" "} {"level":"warn","ts":"2026-04-20T02:05:56.691905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.589294ms","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-04-20T02:05:56.69201Z","caller":"traceutil/trace.go:171","msg":"trace[1874539257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"187.707957ms","start":"2026-04-20T02:05:56.504256Z","end":"2026-04-20T02:05:56.691964Z","steps":["trace[1874539257] 'agreement among raft nodes before linearized reading' (duration: 186.172031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:56.692744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.998453ms","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-04-20T02:05:56.692811Z","caller":"traceutil/trace.go:171","msg":"trace[1032749889] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"292.117166ms","start":"2026-04-20T02:05:56.400676Z","end":"2026-04-20T02:05:56.692793Z","steps":["trace[1032749889] 'agreement among raft nodes before linearized reading' (duration: 289.709379ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:05:56.693032Z","caller":"traceutil/trace.go:171","msg":"trace[1015932220] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"354.686861ms","start":"2026-04-20T02:05:56.338254Z","end":"2026-04-20T02:05:56.692941Z","steps":["trace[1015932220] 'process raft request' (duration: 351.005283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:05:56.694002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:56.338222Z","time spent":"354.871536ms","remote":"127.0.0.1:35284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:06:22.597557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.233354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wsbbv\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-20T02:06:22.597851Z","caller":"traceutil/trace.go:171","msg":"trace[1148067212] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wsbbv; range_end:; response_count:1; response_revision:804; }","duration":"101.585701ms","start":"2026-04-20T02:06:22.496242Z","end":"2026-04-20T02:06:22.597827Z","steps":["trace[1148067212] 'range keys from in-memory index tree' (duration: 100.969028ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:51.773186Z","caller":"traceutil/trace.go:171","msg":"trace[1810771595] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"119.524839ms","start":"2026-04-20T02:06:51.653624Z","end":"2026-04-20T02:06:51.773148Z","steps":["trace[1810771595] 'process raft request' (duration: 118.989917ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:57.103697Z","caller":"traceutil/trace.go:171","msg":"trace[246389974] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1058; }","duration":"107.612219ms","start":"2026-04-20T02:06:56.996053Z","end":"2026-04-20T02:06:57.103666Z","steps":["trace[246389974] 'read index received' (duration: 107.277001ms)","trace[246389974] 'applied index is now lower than readState.Index' (duration: 333.998µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:06:57.104028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.950227ms","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-04-20T02:06:57.104086Z","caller":"traceutil/trace.go:171","msg":"trace[1790601360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1018; }","duration":"108.051819ms","start":"2026-04-20T02:06:56.996018Z","end":"2026-04-20T02:06:57.10407Z","steps":["trace[1790601360] 'agreement among raft nodes before linearized reading' (duration: 107.789173ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:57.104556Z","caller":"traceutil/trace.go:171","msg":"trace[808420027] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"111.543532ms","start":"2026-04-20T02:06:56.992998Z","end":"2026-04-20T02:06:57.104541Z","steps":["trace[808420027] 'process raft request' (duration: 110.480377ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:57.519251Z","caller":"traceutil/trace.go:171","msg":"trace[1074004761] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"408.905248ms","start":"2026-04-20T02:06:57.110318Z","end":"2026-04-20T02:06:57.519223Z","steps":["trace[1074004761] 'process raft request' (duration: 408.761065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:06:57.519475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:57.110298Z","time spent":"409.030212ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:06:57.519694Z","caller":"traceutil/trace.go:171","msg":"trace[1040862994] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"352.065498ms","start":"2026-04-20T02:06:57.167601Z","end":"2026-04-20T02:06:57.519666Z","steps":["trace[1040862994] 'process raft request' (duration: 351.898314ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:06:57.519776Z","caller":"traceutil/trace.go:171","msg":"trace[56892862] linearizableReadLoop","detail":"{readStateIndex:1061; appliedIndex:1059; }","duration":"215.018204ms","start":"2026-04-20T02:06:57.304727Z","end":"2026-04-20T02:06:57.519745Z","steps":["trace[56892862] 'read index received' (duration: 214.303757ms)","trace[56892862] 'applied index is now lower than readState.Index' (duration: 713.307µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:06:57.519831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:57.167577Z","time spent":"352.179551ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:06:57.519983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.24671ms","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-04-20T02:06:57.520027Z","caller":"traceutil/trace.go:171","msg":"trace[1717730172] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1021; }","duration":"215.345191ms","start":"2026-04-20T02:06:57.30467Z","end":"2026-04-20T02:06:57.520016Z","steps":["trace[1717730172] 'agreement among raft nodes before linearized reading' (duration: 215.161507ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:20.051336Z","caller":"traceutil/trace.go:171","msg":"trace[968239095] linearizableReadLoop","detail":"{readStateIndex:1141; appliedIndex:1140; }","duration":"145.254238ms","start":"2026-04-20T02:07:19.906062Z","end":"2026-04-20T02:07:20.051317Z","steps":["trace[968239095] 'read index received' (duration: 145.149235ms)","trace[968239095] 'applied index is now lower than readState.Index' (duration: 104.393µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:07:20.051401Z","caller":"traceutil/trace.go:171","msg":"trace[304782176] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"149.429456ms","start":"2026-04-20T02:07:19.901939Z","end":"2026-04-20T02:07:20.051368Z","steps":["trace[304782176] 'process raft request' (duration: 149.260432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:20.051459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.37804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:07:20.05148Z","caller":"traceutil/trace.go:171","msg":"trace[380409452] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1095; }","duration":"145.428921ms","start":"2026-04-20T02:07:19.906045Z","end":"2026-04-20T02:07:20.051474Z","steps":["trace[380409452] 'agreement among raft nodes before linearized reading' (duration: 145.37554ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:21.886054Z","caller":"traceutil/trace.go:171","msg":"trace[903424672] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"254.758822ms","start":"2026-04-20T02:07:21.631269Z","end":"2026-04-20T02:07:21.886027Z","steps":["trace[903424672] 'process raft request' (duration: 254.610028ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:21.897056Z","caller":"traceutil/trace.go:171","msg":"trace[1368802795] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"265.543616ms","start":"2026-04-20T02:07:21.631488Z","end":"2026-04-20T02:07:21.897032Z","steps":["trace[1368802795] 'process raft request' (duration: 265.371212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:22.238857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.849565ms","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-04-20T02:07:22.238971Z","caller":"traceutil/trace.go:171","msg":"trace[1316398159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1100; }","duration":"183.02164ms","start":"2026-04-20T02:07:22.055923Z","end":"2026-04-20T02:07:22.238945Z","steps":["trace[1316398159] 'range keys from in-memory index tree' (duration: 182.59353ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:22.346071Z","caller":"traceutil/trace.go:171","msg":"trace[528337573] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"102.94758ms","start":"2026-04-20T02:07:22.243099Z","end":"2026-04-20T02:07:22.346047Z","steps":["trace[528337573] 'process raft request' (duration: 102.796246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:22.832849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.506892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:07:22.83297Z","caller":"traceutil/trace.go:171","msg":"trace[1910198864] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1101; }","duration":"175.693866ms","start":"2026-04-20T02:07:22.657249Z","end":"2026-04-20T02:07:22.832942Z","steps":["trace[1910198864] 'count revisions from in-memory index tree' (duration: 175.327278ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:22.960814Z","caller":"traceutil/trace.go:171","msg":"trace[679258756] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"122.239034ms","start":"2026-04-20T02:07:22.83852Z","end":"2026-04-20T02:07:22.96076Z","steps":["trace[679258756] 'process raft request' (duration: 122.020958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:23.389348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.442002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-20T02:07:23.389434Z","caller":"traceutil/trace.go:171","msg":"trace[302532016] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1102; }","duration":"106.580855ms","start":"2026-04-20T02:07:23.282834Z","end":"2026-04-20T02:07:23.389415Z","steps":["trace[302532016] 'range keys from in-memory index tree' (duration: 106.270588ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:23.495283Z","caller":"traceutil/trace.go:171","msg":"trace[2106398750] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"100.580523ms","start":"2026-04-20T02:07:23.394659Z","end":"2026-04-20T02:07:23.495239Z","steps":["trace[2106398750] 'process raft request' (duration: 100.366538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:39.507677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.57071ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-20T02:07:39.507758Z","caller":"traceutil/trace.go:171","msg":"trace[1068613804] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"596.241219ms","start":"2026-04-20T02:07:38.911505Z","end":"2026-04-20T02:07:39.507746Z","steps":["trace[1068613804] 'read index received' (duration: 407.539257ms)","trace[1068613804] 'applied index is now lower than readState.Index' (duration: 188.700982ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:07:39.507841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.339492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:07:39.507857Z","caller":"traceutil/trace.go:171","msg":"trace[1800401258] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1215; }","duration":"596.398803ms","start":"2026-04-20T02:07:38.911453Z","end":"2026-04-20T02:07:39.507852Z","steps":["trace[1800401258] 'agreement among raft nodes before linearized reading' (duration: 596.357722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:39.507875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:38.911431Z","time spent":"596.440224ms","remote":"127.0.0.1:35178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T02:07:39.508085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.627867ms","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-04-20T02:07:39.508103Z","caller":"traceutil/trace.go:171","msg":"trace[1497213846] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1215; }","duration":"429.647917ms","start":"2026-04-20T02:07:39.07845Z","end":"2026-04-20T02:07:39.508098Z","steps":["trace[1497213846] 'agreement among raft nodes before linearized reading' (duration: 429.620047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:39.508117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:39.078406Z","time spent":"429.706599ms","remote":"127.0.0.1:49412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:07:39.508255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.877234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-20T02:07:39.508328Z","caller":"traceutil/trace.go:171","msg":"trace[438075235] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1215; }","duration":"472.005577ms","start":"2026-04-20T02:07:39.036304Z","end":"2026-04-20T02:07:39.50831Z","steps":["trace[438075235] 'agreement among raft nodes before linearized reading' (duration: 471.764672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:07:39.508371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:39.036286Z","time spent":"472.07604ms","remote":"127.0.0.1:35450","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-04-20T02:07:52.025475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.744954ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:07:52.025573Z","caller":"traceutil/trace.go:171","msg":"trace[121052921] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1311; }","duration":"120.716736ms","start":"2026-04-20T02:07:51.90484Z","end":"2026-04-20T02:07:52.025557Z","steps":["trace[121052921] 'read index received' (duration: 11.728946ms)","trace[121052921] 'applied index is now lower than readState.Index' (duration: 108.98651ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:07:52.025706Z","caller":"traceutil/trace.go:171","msg":"trace[1390576337] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"299.856103ms","start":"2026-04-20T02:07:51.725832Z","end":"2026-04-20T02:07:52.025688Z","steps":["trace[1390576337] 'process raft request' (duration: 190.805281ms)","trace[1390576337] 'compare' (duration: 108.472027ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:07:52.025973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.113995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:07:52.026045Z","caller":"traceutil/trace.go:171","msg":"trace[871195836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1258; }","duration":"121.214786ms","start":"2026-04-20T02:07:51.904809Z","end":"2026-04-20T02:07:52.026024Z","steps":["trace[871195836] 'agreement among raft nodes before linearized reading' (duration: 121.118324ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:07:52.194428Z","caller":"traceutil/trace.go:171","msg":"trace[1700276199] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"162.711252ms","start":"2026-04-20T02:07:52.031676Z","end":"2026-04-20T02:07:52.194388Z","steps":["trace[1700276199] 'process raft request' (duration: 140.195653ms)","trace[1700276199] 'compare' (duration: 22.297724ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:07:52.950219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.623581ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T02:07:52.950747Z","caller":"traceutil/trace.go:171","msg":"trace[11337765] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"346.695813ms","start":"2026-04-20T02:07:52.604009Z","end":"2026-04-20T02:07:52.950704Z","steps":["trace[11337765] 'process raft request' (duration: 134.500069ms)","trace[11337765] 'compare' (duration: 211.347985ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:07:52.950868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:07:52.603992Z","time spent":"346.824597ms","remote":"127.0.0.1:35266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T02:07:53.854343Z","caller":"traceutil/trace.go:171","msg":"trace[850505519] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"126.988512ms","start":"2026-04-20T02:07:53.727296Z","end":"2026-04-20T02:07:53.854285Z","steps":["trace[850505519] 'process raft request' (duration: 114.834317ms)","trace[850505519] 'compare' (duration: 11.94042ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:10:51.097057Z","caller":"traceutil/trace.go:171","msg":"trace[857202781] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"155.354619ms","start":"2026-04-20T02:10:50.941676Z","end":"2026-04-20T02:10:51.09703Z","steps":["trace[857202781] 'process raft request' (duration: 155.208075ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:51.099002Z","caller":"traceutil/trace.go:171","msg":"trace[150386630] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"155.248387ms","start":"2026-04-20T02:10:50.943732Z","end":"2026-04-20T02:10:51.09898Z","steps":["trace[150386630] 'process raft request' (duration: 154.890608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:53.575575Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576315318351140129,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T02:10:53.769132Z","caller":"traceutil/trace.go:171","msg":"trace[1862874066] linearizableReadLoop","detail":"{readStateIndex:2307; appliedIndex:2306; }","duration":"694.066831ms","start":"2026-04-20T02:10:53.075037Z","end":"2026-04-20T02:10:53.769104Z","steps":["trace[1862874066] 'read index received' (duration: 693.843046ms)","trace[1862874066] 'applied index is now lower than readState.Index' (duration: 222.835µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:10:53.769203Z","caller":"traceutil/trace.go:171","msg":"trace[381379793] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"708.065456ms","start":"2026-04-20T02:10:53.061115Z","end":"2026-04-20T02:10:53.769181Z","steps":["trace[381379793] 'process raft request' (duration: 707.841311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:53.769346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.061101Z","time spent":"708.164378ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:10:53.769387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.337407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-20T02:10:53.769439Z","caller":"traceutil/trace.go:171","msg":"trace[53473087] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2217; }","duration":"694.41256ms","start":"2026-04-20T02:10:53.07501Z","end":"2026-04-20T02:10:53.769422Z","steps":["trace[53473087] 'agreement among raft nodes before linearized reading' (duration: 694.241036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:53.769532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.074998Z","time spent":"694.524712ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-20T02:10:53.769611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.328626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-20T02:10:53.769599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.442315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T02:10:53.769648Z","caller":"traceutil/trace.go:171","msg":"trace[2079436874] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2217; }","duration":"255.418249ms","start":"2026-04-20T02:10:53.514219Z","end":"2026-04-20T02:10:53.769637Z","steps":["trace[2079436874] 'agreement among raft nodes before linearized reading' (duration: 255.299546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:53.769658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.539776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:528"} {"level":"warn","ts":"2026-04-20T02:10:53.769691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.743078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-20T02:10:53.769745Z","caller":"traceutil/trace.go:171","msg":"trace[249669566] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2217; }","duration":"494.698791ms","start":"2026-04-20T02:10:53.275024Z","end":"2026-04-20T02:10:53.769723Z","steps":["trace[249669566] 'agreement among raft nodes before linearized reading' (duration: 494.397344ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:53.769751Z","caller":"traceutil/trace.go:171","msg":"trace[1926369037] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2217; }","duration":"493.81459ms","start":"2026-04-20T02:10:53.27592Z","end":"2026-04-20T02:10:53.769735Z","steps":["trace[1926369037] 'agreement among raft nodes before linearized reading' (duration: 493.697127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:53.769805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.274999Z","time spent":"494.791482ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-20T02:10:53.769809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.27591Z","time spent":"493.883721ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-20T02:10:53.769837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.639414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"info","ts":"2026-04-20T02:10:53.76987Z","caller":"traceutil/trace.go:171","msg":"trace[815154804] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2217; }","duration":"650.687505ms","start":"2026-04-20T02:10:53.11917Z","end":"2026-04-20T02:10:53.769857Z","steps":["trace[815154804] 'agreement among raft nodes before linearized reading' (duration: 650.604023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:53.769754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.868497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T02:10:53.769905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.119155Z","time spent":"650.741796ms","remote":"127.0.0.1:35290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":645,"request content":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-04-20T02:10:53.769688Z","caller":"traceutil/trace.go:171","msg":"trace[737126147] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2217; }","duration":"667.555477ms","start":"2026-04-20T02:10:53.102107Z","end":"2026-04-20T02:10:53.769662Z","steps":["trace[737126147] 'agreement among raft nodes before linearized reading' (duration: 667.289011ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:53.76993Z","caller":"traceutil/trace.go:171","msg":"trace[1051550942] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2217; }","duration":"501.109723ms","start":"2026-04-20T02:10:53.26881Z","end":"2026-04-20T02:10:53.769919Z","steps":["trace[1051550942] 'agreement among raft nodes before linearized reading' (duration: 500.910179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:53.769966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.268795Z","time spent":"501.159004ms","remote":"127.0.0.1:35382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:10:53.769959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.102096Z","time spent":"667.844235ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T02:10:53.770137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.49432ms","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-04-20T02:10:53.770184Z","caller":"traceutil/trace.go:171","msg":"trace[1311718205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2217; }","duration":"660.535531ms","start":"2026-04-20T02:10:53.10963Z","end":"2026-04-20T02:10:53.770165Z","steps":["trace[1311718205] 'agreement among raft nodes before linearized reading' (duration: 660.421408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:53.770222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.109551Z","time spent":"660.661563ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T02:10:54.408229Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576315318351140141,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:10:54.909049Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576315318351140141,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:10:55.409387Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576315318351140141,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T02:10:55.632891Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.844056826s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T02:10:55.660354Z","caller":"traceutil/trace.go:171","msg":"trace[697475660] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"1.88606766s","start":"2026-04-20T02:10:53.774261Z","end":"2026-04-20T02:10:55.660329Z","steps":["trace[697475660] 'process raft request' (duration: 1.858919482s)","trace[697475660] 'compare' (duration: 26.38536ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T02:10:55.660557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.77424Z","time spent":"1.886241613s","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:10:55.66077Z","caller":"traceutil/trace.go:171","msg":"trace[597284219] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"1.886445098s","start":"2026-04-20T02:10:53.774314Z","end":"2026-04-20T02:10:55.660759Z","steps":["trace[597284219] 'process raft request' (duration: 1.885944466s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:55.660833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.774283Z","time spent":"1.88652046s","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:10:55.661234Z","caller":"traceutil/trace.go:171","msg":"trace[716838982] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"1.886611494s","start":"2026-04-20T02:10:53.774602Z","end":"2026-04-20T02:10:55.661213Z","steps":["trace[716838982] 'process raft request' (duration: 1.886114871s)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:55.661429Z","caller":"traceutil/trace.go:171","msg":"trace[1543149367] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"1.886524791s","start":"2026-04-20T02:10:53.774892Z","end":"2026-04-20T02:10:55.661417Z","steps":["trace[1543149367] 'process raft request' (duration: 1.886252205s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:55.661501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.774882Z","time spent":"1.886584563s","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:10:55.66161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.774573Z","time spent":"1.886788097s","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:10:55.661798Z","caller":"traceutil/trace.go:171","msg":"trace[1009812406] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"1.886605583s","start":"2026-04-20T02:10:53.775179Z","end":"2026-04-20T02:10:55.661785Z","steps":["trace[1009812406] 'process raft request' (duration: 1.886192633s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:55.661865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.775168Z","time spent":"1.886663784s","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":495,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:10:55.66213Z","caller":"traceutil/trace.go:171","msg":"trace[1247060930] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"1.886820518s","start":"2026-04-20T02:10:53.775295Z","end":"2026-04-20T02:10:55.662115Z","steps":["trace[1247060930] 'process raft request' (duration: 1.886452759s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:55.662274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.775283Z","time spent":"1.886947862s","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T02:10:55.681622Z","caller":"traceutil/trace.go:171","msg":"trace[613527268] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"1.888829345s","start":"2026-04-20T02:10:53.792773Z","end":"2026-04-20T02:10:55.681602Z","steps":["trace[613527268] 'process raft request' (duration: 1.888706152s)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:55.681576Z","caller":"traceutil/trace.go:171","msg":"trace[1928605266] linearizableReadLoop","detail":"{readStateIndex:2317; appliedIndex:2308; }","duration":"1.774310022s","start":"2026-04-20T02:10:53.90725Z","end":"2026-04-20T02:10:55.68156Z","steps":["trace[1928605266] 'read index received' (duration: 1.725927037s)","trace[1928605266] 'applied index is now lower than readState.Index' (duration: 48.380255ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:10:55.681736Z","caller":"traceutil/trace.go:171","msg":"trace[1184699285] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"1.022226856s","start":"2026-04-20T02:10:54.65949Z","end":"2026-04-20T02:10:55.681717Z","steps":["trace[1184699285] 'process raft request' (duration: 1.022032451s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:55.681833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:54.65947Z","time spent":"1.022316287s","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:10:55.681715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.792759Z","time spent":"1.888911248s","remote":"127.0.0.1:35290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":606,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:10:55.681882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.774634209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:10:55.681691Z","caller":"traceutil/trace.go:171","msg":"trace[1460652615] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"1.891807937s","start":"2026-04-20T02:10:53.789829Z","end":"2026-04-20T02:10:55.681637Z","steps":["trace[1460652615] 'process raft request' (duration: 1.891555921s)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:55.682026Z","caller":"traceutil/trace.go:171","msg":"trace[2124284402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2226; }","duration":"1.774823794s","start":"2026-04-20T02:10:53.907188Z","end":"2026-04-20T02:10:55.682012Z","steps":["trace[2124284402] 'agreement among raft nodes before linearized reading' (duration: 1.774573548s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:55.682107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.034369625s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T02:10:55.682161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.907162Z","time spent":"1.774895026s","remote":"127.0.0.1:35168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T02:10:55.682156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:53.789815Z","time spent":"1.892229567s","remote":"127.0.0.1:35212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T02:10:55.682191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.071541792s","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-04-20T02:10:55.682171Z","caller":"traceutil/trace.go:171","msg":"trace[1439626210] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2226; }","duration":"1.034503768s","start":"2026-04-20T02:10:54.647654Z","end":"2026-04-20T02:10:55.682158Z","steps":["trace[1439626210] 'agreement among raft nodes before linearized reading' (duration: 1.034372175s)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:55.682237Z","caller":"traceutil/trace.go:171","msg":"trace[866908822] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2226; }","duration":"1.071611004s","start":"2026-04-20T02:10:54.610616Z","end":"2026-04-20T02:10:55.682227Z","steps":["trace[866908822] 'agreement among raft nodes before linearized reading' (duration: 1.07145088s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:55.682251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:54.647625Z","time spent":"1.034616011s","remote":"127.0.0.1:35534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":31,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:10:55.682275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:54.610598Z","time spent":"1.071670495s","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T02:10:55.682146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.477137526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:10:55.682496Z","caller":"traceutil/trace.go:171","msg":"trace[1614650614] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2226; }","duration":"1.477534286s","start":"2026-04-20T02:10:54.204941Z","end":"2026-04-20T02:10:55.682476Z","steps":["trace[1614650614] 'agreement among raft nodes before linearized reading' (duration: 1.477069645s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:55.68263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:54.204919Z","time spent":"1.477668858s","remote":"127.0.0.1:49530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-20T02:10:55.682415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074944215s","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-04-20T02:10:55.683119Z","caller":"traceutil/trace.go:171","msg":"trace[330502261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2226; }","duration":"1.075737283s","start":"2026-04-20T02:10:54.607366Z","end":"2026-04-20T02:10:55.683104Z","steps":["trace[330502261] 'agreement among raft nodes before linearized reading' (duration: 1.074903844s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:55.683247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:10:54.607345Z","time spent":"1.075881996s","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-20T02:10:55.92838Z","caller":"traceutil/trace.go:171","msg":"trace[1674959806] transaction","detail":"{read_only:false; response_revision:2228; number_of_response:1; }","duration":"241.197019ms","start":"2026-04-20T02:10:55.687143Z","end":"2026-04-20T02:10:55.92834Z","steps":["trace[1674959806] 'process raft request' (duration: 217.623877ms)","trace[1674959806] 'compare' (duration: 23.097941ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:10:55.928486Z","caller":"traceutil/trace.go:171","msg":"trace[565287893] linearizableReadLoop","detail":"{readStateIndex:2319; appliedIndex:2317; }","duration":"240.972394ms","start":"2026-04-20T02:10:55.687474Z","end":"2026-04-20T02:10:55.928447Z","steps":["trace[565287893] 'read index received' (duration: 31.107393ms)","trace[565287893] 'applied index is now lower than readState.Index' (duration: 209.86224ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T02:10:55.928542Z","caller":"traceutil/trace.go:171","msg":"trace[2007211670] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"238.470153ms","start":"2026-04-20T02:10:55.690045Z","end":"2026-04-20T02:10:55.928515Z","steps":["trace[2007211670] 'process raft request' (duration: 238.159906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:55.928718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.226629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-20T02:10:55.928751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.654887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T02:10:55.928857Z","caller":"traceutil/trace.go:171","msg":"trace[236020684] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2229; }","duration":"238.820612ms","start":"2026-04-20T02:10:55.690023Z","end":"2026-04-20T02:10:55.928844Z","steps":["trace[236020684] 'agreement among raft nodes before linearized reading' (duration: 238.647108ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:55.928781Z","caller":"traceutil/trace.go:171","msg":"trace[1542564215] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2229; }","duration":"241.339222ms","start":"2026-04-20T02:10:55.687426Z","end":"2026-04-20T02:10:55.928765Z","steps":["trace[1542564215] 'agreement among raft nodes before linearized reading' (duration: 241.199929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T02:10:56.280378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.573553ms","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-04-20T02:10:56.280722Z","caller":"traceutil/trace.go:171","msg":"trace[406456260] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2229; }","duration":"183.947842ms","start":"2026-04-20T02:10:56.096747Z","end":"2026-04-20T02:10:56.280695Z","steps":["trace[406456260] 'range keys from in-memory index tree' (duration: 183.545822ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T02:10:57.869591Z","caller":"traceutil/trace.go:171","msg":"trace[1313591815] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"105.95017ms","start":"2026-04-20T02:10:57.763588Z","end":"2026-04-20T02:10:57.869538Z","steps":["trace[1313591815] 'process raft request' (duration: 88.394121ms)","trace[1313591815] 'compare' (duration: 17.406635ms)"],"step_count":2}